起動時 SEVERE: Failed Inspecting plugin が発生しプラグインが読み込めない

[Takayuki Kondou]

こんばんは。近藤と申します。いつも Jenkins さんにはお世話になっております。

Jenkins-slaveにしていたあるマシンが、気づいたら オフライン状態と
なっておりました。いくつかのマシンで発生していてJREをアップデートすると現象が
改善されることがわかり、JRE 7 Update 6 にアップデートしました。

下記エラーでプラグインが読み込めない状態となるマシンがあります。

JRE と、Jenkinsをアンインストール、インストールしても状況は変わりませんでした。
なにかお気づきの点があればアドバイス頂けませんか？

* 環境
- Windows 7 Professional 32-bit
- JRE 7 Update 6
- Jenkins 1.478 (C:\Jenkins にインストール)

以下のエラーログは、コマンドプロンプトから、
C:\Jenkins>java -jar jenkins.war >> jenkins-err-log.txttxt 2>&1
を実行した結果です。

よろしくお願いします。

--
Running from: C:\Jenkins\jenkins.war
webroot: $user.home/.jenkins
8 24, 2012 7:39:02 午後 winstone.Logger logInternal
情報: Beginning extraction from war file
Jenkins home directory: C:\Users\tkondou\.jenkins found at: $user.home/.jenkins
8 24, 2012 7:39:23 午後 winstone.Logger logInternal
情報: HTTP Listener started: port=8080
8 24, 2012 7:39:24 午後 winstone.Logger logInternal
情報: AJP13 Listener started: port=8009
8 24, 2012 7:39:24 午後 winstone.Logger logInternal
情報: Winstone Servlet Engine v0.9.10 running: controlPort=disabled
8 24, 2012 7:39:24 午後 jenkins.InitReactorRunner$1 onAttained
情報: Started initialization
8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin C:\Users\tkondou\.jenkins\plugins\ant.jpi
java.lang.UnsatisfiedLinkError: Unable to load library 'kernel32':
com.sun.jna.Native.open(Ljava/lang/String;)J
at com.sun.jna.NativeLibrary.loadLibrary(NativeLibrary.java:166)
at com.sun.jna.NativeLibrary.getInstance(NativeLibrary.java:239)
at com.sun.jna.Library$Handler.<init>(Library.java:140)
at com.sun.jna.Native.loadLibrary(Native.java:366)
at com.sun.jna.Native.loadLibrary(Native.java:351)
at hudson.util.jna.Kernel32.<clinit>(Kernel32.java:38)
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin C:\Users\tkondou\.jenkins\plugins\cvs.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin
C:\Users\tkondou\.jenkins\plugins\external-monitor-job.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin C:\Users\tkondou\.jenkins\plugins\javadoc.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin C:\Users\tkondou\.jenkins\plugins\ldap.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin
C:\Users\tkondou\.jenkins\plugins\maven-plugin.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin C:\Users\tkondou\.jenkins\plugins\pam-auth.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin
C:\Users\tkondou\.jenkins\plugins\ssh-slaves.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin
C:\Users\tkondou\.jenkins\plugins\subversion.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onTaskFailed
SEVERE: Failed Inspecting plugin
C:\Users\tkondou\.jenkins\plugins\translation.jpi
java.lang.NoClassDefFoundError: Could not initialize class
hudson.util.jna.Kernel32
at hudson.util.jna.Kernel32Utils.isJunctionOrSymlink(Kernel32Utils.java:62)
at hudson.Util.isSymlink(Util.java:314)
at hudson.Util.deleteRecursive(Util.java:279)
at hudson.ClassicPluginStrategy.explode(ClassicPluginStrategy.java:403)
at hudson.ClassicPluginStrategy.createPluginWrapper(ClassicPluginStrategy.java:117)
at hudson.PluginManager$1$3$1.run(PluginManager.java:207)
at org.jvnet.hudson.reactor.TaskGraphBuilder$TaskImpl.run(TaskGraphBuilder.java:146)
at org.jvnet.hudson.reactor.Reactor.runTask(Reactor.java:259)
at jenkins.model.Jenkins$7.runTask(Jenkins.java:879)
at org.jvnet.hudson.reactor.Reactor$2.run(Reactor.java:187)
at org.jvnet.hudson.reactor.Reactor$Node.run(Reactor.java:94)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)

8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onAttained
情報: Listed all plugins
8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onAttained
情報: Prepared all plugins
8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onAttained
情報: Started all plugins
8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onAttained
情報: Augmented all extensions
8 24, 2012 7:39:25 午後 jenkins.InitReactorRunner$1 onAttained
情報: Loaded all jobs
8 24, 2012 7:39:27 午後
org.apache.sshd.common.util.SecurityUtils$BouncyCastleRegistration run
情報: Trying to register BouncyCastle as a JCE provider
8 24, 2012 7:39:28 午後
org.apache.sshd.common.util.SecurityUtils$BouncyCastleRegistration run
情報: Registration succeeded
8 24, 2012 7:39:28 午後 org.jenkinsci.main.modules.sshd.SSHD start
情報: Started SSHD at port 49327
8 24, 2012 7:39:28 午後 jenkins.InitReactorRunner$1 onAttained
情報: Completed initialization
8 24, 2012 7:39:28 午後 hudson.TcpSlaveAgentListener <init>
情報: JNLP slave agent listener started on TCP port 49328
8 24, 2012 7:39:28 午後 hudson.WebAppMain$2 run
情報: Jenkins is fully up and running
--



--
Takayuki KONDO (tko...@gmail.com)

[Seiji Sogabe]

曽我部です。

2012/8/24 Takayuki Kondou <tko...@gmail.com>:

> こんばんは。近藤と申します。いつも Jenkins さんにはお世話になっております。
>
> Jenkins-slaveにしていたあるマシンが、気づいたら オフライン状態と
> なっておりました。いくつかのマシンで発生していてJREをアップデートすると現象が
> 改善されることがわかり、JRE 7 Update 6 にアップデートしました。

アップデートしてからプラグインが読み込めない状態になったのでしょうか。
それとも、オフライン状態になっている状態で、下記のログがでていたのでしょうか。
# 前後関係がよくわかりません。

私の環境(Win7 64bit, JavaSE7 update6, Jenkins 1.478)では、少なくともプラグインの読み込みが
正常に終了し、動作しています。

ログの中に、

> java.lang.UnsatisfiedLinkError: Unable to load library 'kernel32':

とあります。
Windowsのkernel32.dllを正常にロードできなかったようです。
Windowsには詳しくありませんが、kernel32.dllで検索すると、Windosの環境に
問題があるように見えます。他のアプリケーションを動かした時に、
異常終了とかしないでしょうか。
リカバリの方法もいくつかあるようですので、そちらをためしてみたらいかがでしょうか。

--
s.sogabe at gmail.com

[Takayuki Kondou]

近藤です。

曽我部様、返信ありがとうございます。
もう一台同じ現象が出るマシンが発生するようになりました。下記2台です。

1. Windows 7 Professionai 32-bit slave として使用 (最初の報告）
2. Windows 7 XP master および slave として使用（新たに現象発生）

Jenkins以外のプログラムは、特に影響が出ていません。JREを別に抱えていますがEclipseベースのIDEも問題ないです。

○ 実施対策
下記を行いましたが、現象は回復しませんでした

1. ページングファイルの削除　　http://nagabuchi.jugem.jp/?eid=258
2. 一時ファイルの削除
3. sfc.exe /VERIFYFILE=c:\windows\system32\kernel32.dll

下記は未実施（メーカ製プリインストールモデルでリカバリDVDしかなくWindowsXPだと実施できない）
4. sfc /scannow （システムファイルの修復コマンド）


○ 回避策
回避策として、Jenkins 1.466.2 を使用することで動作するようになりました



また、なにか解決策や進展があったらご報告させていただきます。

--
Takayuki KONDO (tko...@gmail.com)