[JENKINS-34708] Installation Wizard hangs infinitely in Install Screen

[timja]

I'm experimenting with a custom Jenkins WAR file build. This build defines a custom update site, from which Jenkins takes plugins.

So the steps I perform:
1) Launch Jenkins with installation wizard
2) Go to the fine-grain select
3) Keep everything by default and press OK

Expected result:
1) Jenkins installs all plugins and starts up

Actual result:
1) Jenkins installs the most of the plugins
2) Build timeout and matrix auth cannot be enabled according to logs
3) The web UI hangs infinitely
4) According to the filesystem, plugin.jpi.disabled files just do not exist at this time

The only useful info in the installation wizard is a stacktrace:

May 10, 2016 2:36:53 PM hudson.model.UpdateCenter$EnableJob run
SEVERE: Failed to enable Matrix Authorization Strategy Plugin
java.io.IOException: Failed to delete /Users/nenashev/Documents/XXX/tmp/plugins/matrix-auth.jpi.disabled
    at hudson.PluginWrapper.enable(PluginWrapper.java:444)
    at hudson.model.UpdateCenter$EnableJob.run(UpdateCenter.java:1447)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
    at java.util.concurrent.FutureTask.run(FutureTask.java:266)
    at hudson.remoting.AtmostOneThreadExecutor$Worker.run(AtmostOneThreadExecutor.java:110)
    at java.lang.Thread.run(Thread.java:745)

---

Originally reported by oleg_nenashev, imported from: Installation Wizard hangs infinitely in Install Screen

• status: Open
• priority: Major
• resolution: Unresolved
• imported: 2022/01/10

[timja]

oleg_nenashev:

Working on it

[timja]

oleg_nenashev:

I've fixed one of the causes: JENKINS-34710. But seems there are still issues. Needs investigation

[timja]

kzantow:

Issue seems to be the EnableJob was not setting status in any case of success or failure.

[timja]

scm_issue_link:

Code changed in jenkins
User: Keith Zantow
Path:
core/src/main/java/hudson/model/UpdateCenter.java
http://jenkins-ci.org/commit/jenkins/7319b679d669db8cb4129188d6a4a64b06a69070
Log:
JENKINS-34708 - UpdateCenter.EnableJob not properly setting status (#2365)

• JENKINS-34708 - UpdateCenter.EnableJob not properly setting status

• Restore if (status instanceof Pending)

[timja]

oleg_nenashev:

Released as Jenkins-2.6

[timja]

jet_1974:

Hi,

 

I am having a similar issue with Jenkins. I have installed jenkins used the initial admin userid and the initial password its hanging forever. I don't see any messages in nohup.out other than jenkins is up and running.

 

Given below is the nohup.out

This may also be found at: /u01/jenkins/secrets/initialAdminPassword

*************************************************************
*************************************************************
*************************************************************

Oct 30, 2017 10:17:19 AM hudson.model.UpdateSite updateData
INFO: Obtained the latest update center data file for UpdateSource default
Oct 30, 2017 10:17:19 AM hudson.WebAppMain$3 run
INFO: Jenkins is fully up and running

 

Given below is the screenshot.

 

[timja]

jet_1974:

Hi Keith,

 

JENKINS Hangs forever without any log messages

Can you please look into my issue? I have attached sample screenshots from  the install jenkins.

I have used the initial userid and password but i am unable to login.

I don't see any log files with log errors under logs directory.

I see a tasks directory with started and finished messages without any error messages.

 

Given below is a screenshot of the login.

 

last date and time log dir got updated

drwxrwxr-x.  3 esmadmin esmadmin     4096 Oct 27 09:58 logs

contents of the log dir

 

[esmadmin@identity_server7 jenkins]$ cd logs
[esmadmin@identity_server7 logs]$ ls -latr
total 12
drwxrwxr-x.  3 esmadmin esmadmin 4096 Oct 27 09:58 .
drwxrwxr-x. 11 esmadmin esmadmin 4096 Oct 30 10:43 ..
drwxrwxr-x.  2 esmadmin esmadmin 4096 Oct 30 10:44 tasks
[esmadmin@identity_server7 logs]$ cd tasks/
[esmadmin@identity_server7 tasks]$ ls -latr
total 24
drwxrwxr-x. 3 esmadmin esmadmin 4096 Oct 27 09:58 ..
rw-rw-r-. 1 esmadmin esmadmin   90 Oct 27 09:58 Download metadata.log.3
rw-rw-r-. 1 esmadmin esmadmin   87 Oct 27 10:53 Download metadata.log.2
rw-rw-r-. 1 esmadmin esmadmin   89 Oct 30 09:40 Download metadata.log.1
rw-rw-r-. 1 esmadmin esmadmin   86 Oct 30 10:17 Download metadata.log
drwxrwxr-x. 2 esmadmin esmadmin 4096 Oct 30 10:44 .

[esmadmin@identity_server7 tasks]$ vi Download\ metadata.log
[esmadmin@identity_server7 tasks]$ cat Download\ metadata.log
Started at Mon Oct 30 10:17:12 EDT 2017
Finished at Mon Oct 30 10:17:12 EDT 2017. 5ms
[esmadmin@identity_server7 tasks]$ cat Download\ metadata.log.1
Started at Mon Oct 30 09:39:57 EDT 2017
Finished at Mon Oct 30 09:40:07 EDT 2017. 9510ms

nohup.out and date and time

esmadmin@identity_server7 jenkins]$ ls -al nohup.out
rw------. 1 esmadmin esmadmin 91160 Oct 30 10:17 nohup.out

 

latest contents of nohup.out since the current start

Oct 30, 2017 10:17:06 AM Main deleteWinstoneTempContents
WARNING: Failed to delete the temporary Winstone file /tmp/winstone/jenkins.war
Oct 30, 2017 10:17:06 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: Logging initialized @603ms
Oct 30, 2017 10:17:06 AM winstone.Logger logInternal
INFO: Beginning extraction from war file
Oct 30, 2017 10:17:06 AM org.eclipse.jetty.util.log.JavaUtilLog warn
WARNING: Empty contextPath
Oct 30, 2017 10:17:06 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: jetty-9.2.z-SNAPSHOT
Oct 30, 2017 10:17:07 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: NO JSP Support for /, did not find org.eclipse.jetty.jsp.JettyJspServlet
Jenkins home directory: /u01/jenkins found at: EnvVars.masterEnvVars.get("JENKINS_HOME")
Oct 30, 2017 10:17:08 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: Started w.@4145bad8{/,file:/u01/jenkins/war/,AVAILABLE}{/u01/jenkins/war}
Oct 30, 2017 10:17:08 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: Started ServerConnector@7674f035{HTTP/1.1}{0.0.0.0:8080}
Oct 30, 2017 10:17:08 AM org.eclipse.jetty.util.log.JavaUtilLog info
INFO: Started @2770ms
Oct 30, 2017 10:17:08 AM winstone.Logger logInternal
INFO: Winstone Servlet Engine v2.0 running: controlPort=disabled
Oct 30, 2017 10:17:09 AM jenkins.InitReactorRunner$1 onAttained
INFO: Started initialization
Oct 30, 2017 10:17:09 AM jenkins.InitReactorRunner$1 onAttained
INFO: Listed all plugins
Oct 30, 2017 10:17:11 AM jenkins.InitReactorRunner$1 onAttained
INFO: Prepared all plugins
Oct 30, 2017 10:17:11 AM jenkins.InitReactorRunner$1 onAttained
INFO: Started all plugins
Oct 30, 2017 10:17:11 AM jenkins.InitReactorRunner$1 onAttained
INFO: Augmented all extensions
Oct 30, 2017 10:17:11 AM jenkins.InitReactorRunner$1 onAttained
INFO: Loaded all jobs
Oct 30, 2017 10:17:12 AM hudson.model.AsyncPeriodicWork$1 run
INFO: Started Download metadata
Oct 30, 2017 10:17:12 AM hudson.model.AsyncPeriodicWork$1 run
INFO: Finished Download metadata. 5 ms
Oct 30, 2017 10:17:13 AM jenkins.InitReactorRunner$1 onAttained
INFO: Completed initialization
Oct 30, 2017 10:17:14 AM org.springframework.context.support.AbstractApplicationContext prepareRefresh
INFO: Refreshing org.springframework.web.context.support.StaticWebApplicationContext@4fa52bb2: display name [Root WebApplicationContext]; startup date [Mon Oct 30 10:17:14 EDT 2017]; root of context hierarchy
Oct 30, 2017 10:17:14 AM org.springframework.context.support.AbstractApplicationContext obtainFreshBeanFactory
INFO: Bean factory for application context [org.springframework.web.context.support.StaticWebApplicationContext@4fa52bb2]: org.springframework.beans.factory.support.DefaultListableBeanFactory@604d2a94
Oct 30, 2017 10:17:14 AM org.springframework.beans.factory.support.DefaultListableBeanFactory preInstantiateSingletons
INFO: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@604d2a94: defining beans [authenticationManager]; root of factory hierarchy
Oct 30, 2017 10:17:14 AM org.springframework.context.support.AbstractApplicationContext prepareRefresh
INFO: Refreshing org.springframework.web.context.support.StaticWebApplicationContext@7f4e305d: display name [Root WebApplicationContext]; startup date [Mon Oct 30 10:17:14 EDT 2017]; root of context hierarchy
Oct 30, 2017 10:17:14 AM org.springframework.context.support.AbstractApplicationContext obtainFreshBeanFactory
INFO: Bean factory for application context [org.springframework.web.context.support.StaticWebApplicationContext@7f4e305d]: org.springframework.beans.factory.support.DefaultListableBeanFactory@7ab5b3e7
Oct 30, 2017 10:17:14 AM org.springframework.beans.factory.support.DefaultListableBeanFactory preInstantiateSingletons
INFO: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@7ab5b3e7: defining beans [filter,legacy]; root of factory hierarchy
Oct 30, 2017 10:17:14 AM jenkins.install.SetupWizard init
INFO:

*************************************************************
*************************************************************
*************************************************************

Jenkins initial setup is required. An admin user has been created and a password generated.
Please use the following password to proceed to installation:

01aeaf99a11d47598c3337a7f3c66f9c

This may also be found at: /u01/jenkins/secrets/initialAdminPassword

*************************************************************
*************************************************************
*************************************************************

Oct 30, 2017 10:17:19 AM hudson.model.UpdateSite updateData
INFO: Obtained the latest update center data file for UpdateSource default
Oct 30, 2017 10:17:19 AM hudson.WebAppMain$3 run
INFO: Jenkins is fully up and running
                                                              __                                                              

 

[timja]

kzantow:

jet_1974 Please provide the exact steps you've taken in order to reproduce this issue. Also please provide information about your setup: behind a proxy? What OS? How did you install Jenkins - war? package? etc. What browser? Are there browser errors?

[timja]

jet_1974:

Oleg,

 

This issue is happening in a different version of Jenkins 2.46.2. The issue happens to be in the initial startup itself.

 

 

[timja]

jet_1974:

i tried to reopen the issue but for some reason it is still assigned to you. Shouldn't the assignment change to me instead of you?

[timja]

jet_1974:

Please use the new JENKINS-47734 ticket that i created.

[timja]

[Originally related to: JENKINS-34710]

[timja]

[Originally related to: JENKINS-47734]