Я получаю странное поведение, когда мой подчиненный Windows приостанавливается после того, как я перезагружаю подчиненную виртуальную машину Azure (обслуживание), и состояние приостановки не удаляется, когда ведомое устройство снова работает и успешно подключено к Jenkins.
Я повторил это 3 раза - с каждой виртуальной машиной я устанавливал дополнительное программное обеспечение вручную, что требует перезагрузки, но после перезагрузки любое запланированное задание сборки зависает с сообщением «Ожидание следующего доступного исполнителя в Windows».«подчиненный узел в Jenkins показывается как подключенный к сети, но рядом с ним находится« (приостановлено) », а затем плагин« Агенты виртуальных машин Azure »просто создает новую виртуальную машину и запускает сборку на ней.
Извлечение из журналов:
25 мая 2018 15:47:29 hudson.remoting.SynchronousCommandTransport $ ReaderThread run SEVERE: Ошибка ввода-вывода в канале slavew823810 java.io.IOException: Неожиданное завершение канала в hudson.remoting.SynchronousCommandTransport $ ReaderThread.run (SynchronousCommandTransport.java:77)Вызывается:(ObjectInputStream.java:862) в java.io.ObjectInputStream. (ObjectInputStream.java:358) в hudson.remoting.ObjectInputStreamEx. (ObjectInputStreamEx.java:48) в hudson.remoting.AbstractSynchronousByteArrayCommandTransport.raymand.yn.Art.at hudson.remoting.SynchronousCommandTransport $ ReaderThread.run (SynchronousCommandTransport.java:63)
25 мая 2018 15:47:34 hudson.model.AsyncPeriodicWork $ 1 запустить ИНФОРМАЦИЯ: Запущены агенты виртуальной машины Azure Очистить задачу 25 мая, 2018 15:47:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask выполнить INFO: AzureVMAgentCleanUpTask: выполнить: запуск 25 мая 2018 15:47:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTaskTureSecTureSecUpTureK выполнитьВосстановить AzO:: RUnning clean с 5-минутным таймаутом 25 мая 2018 15:47:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanVMs ИНФОРМАЦИЯ: AzureVMAgentCleanUpTask: cleanVMs: узел slavew56f680 заблокирован для очистки 25 мая 2018 15:47:34 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate virtualMachineExists ИНФОРМАЦИЯ: AzureVMManagementServiceDelegate: virtualMachineExists: проверка для slavew823810 25 мая 2018 15:47:34 com.microsoft.rest.interceptors.LoggingInterceptor log INFO: -Сброс соединения 25 мая 2018 15:47:34 okhttp3.internal.platform.Platform log ИНФОРМАЦИЯ: обратный вызов ALPN сброшен: SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:47:35 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate virtualMachineExists ИНФОРМАЦИЯ: AzureVMManagementServiceDelegate: virtualMachineExists: slavew823810 существует 25 мая 2018 3:47:35 com.microsoft.azurezAAzureVMAgentCleanUpTask: cleanDeployments: очистка развертываний 25 мая 2018 г. 15:47:35 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanDeployments ИНФОРМАЦИЯ: AzureVMAgentCleanUpTask: cleanDeployments: выполнено очистка развертываний 47 мая 2015 г., 3:35, com.m:35, com, 22:00, 2018Информация о вызове2018 15:47:35 PM com.microsoft.azure.vmagent.AzureVMAgent выключение INFO: AzureVMAgent: завершение работы: завершение работы агента slavew823810 25 мая 2018 15:47:35 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate shutdownVirtualMachine ИНФОРМАЦИЯ: AzureVMManagementServiceDelegate:shutdownVirtualMachine: вызвано для slavew823810 25 мая 2018 г. 15:47:35 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask выполнить INFO: AzureVMAgentCleanUpTask: выполнить: конец 25 мая 2018 15:47:35 hudson.model.Asorkc INFO: Завершена задача очистки агентов виртуальной машины Azure.389 мс 25 мая 2018 г. 15:47:35 okhttp3.internal.platform.Platform log ИНФО: Отозван обратный вызов ALPN: SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:49:09 запуск hudson.model.AsyncPeriodicWork $ 1 ИНФОРМАЦИЯ: Запущенный размер пула сопровождающего виртуальной машины Azure 25 мая 2018 15:49:09 запуск hudson.model.AsyncPeriodicWork $ 1 ИНФОРМАЦИЯ: Законченный размер пула сопровождающего виртуальной машины Azure,1 мс 25 мая 2018 15:51:04 hudson.model.AsyncPeriodicWork $ 1 запуск ИНФОРМАЦИЯ: Запущена задача проверки виртуальной машины Azure 25 мая 2018 15:51:04 com.microsoft.azure.vmagent.AzureVMCloudVerificationTask getVirtualMachineCount INFO: AzureVMkVid:getVirtualMachineCount: запуск 25 мая 2018 г. 15:51:04.model.AsyncPeriodicWork $ 1 run INFO: Завершенная задача проверки виртуальной машины Azure.39 мс 25 мая 2018 15:52:34 hudson.model.AsyncPeriodicWork $ 1 запуск ИНФОРМАЦИЯ: Запущена задача очистки агентов VM Azure 25 мая 2018 15:52:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask выполнить ИНФО: AzureVMAgentCleanUpTask: execute: start 25 мая 2018 15:52:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask execute INFO: AzureVMAgentCleanUpTask: execute: запуск без перерыва с 5-минутным тайм-аутом 25 мая 2018 15:52:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanVMs ИНФОРМАЦИЯ: AzureVMAgentCleanUpTask: cleanVMs: узел slavew56f680 заблокирован для очистки 25 мая 2018 15:52, 2018 15:52:34 вечера com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanDeployments INFO: AzureVMAgentCleanUpTask: cleanDeployments: развертывания очистки 25 мая 2018 15:52:comeanUpTask: cleanDeployments: выполнено очистка развертываний 25 мая 2018 15:52:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask выполнить INFO: AzureVMAgentCleanUpTask: выполнить: конец 25 мая 2018 15:52:34 hudson.model.Work 1 $запустите INFO: завершена задача очистки агентов виртуальной машины Azure.21 мс, 25 мая 2018 15:53:00 hudson.node_monitors.ResponseTimeMonitor $ 1 монитор ПРЕДУПРЕЖДЕНИЕ: отключение slavew56f680, поскольку он не отвечает 25 мая 2018 15:53:09 hudson.node_monitors.ResponseTimeMonitor $ 1 предупреждение ПРЕДУПРЕЖДЕНИЕ: отключение slavew56f680потому что он не отвечает 25 мая 2018 15:54:09 вечера запуск hudson.model.AsyncPeriodicWork $ 1 ИНФОРМАЦИЯ: Запущен размер пула сопровождающего виртуальной машины Azure 25 мая 2018 15:54:09 вечера запуск hudson.model.AsyncPeriodicWork $ 1 ИНФО: завершено AzureРазмер пула сопровождающего VM.1 мс 25 мая 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher launch ИНФО: AzureVMAgentSSHLauncher: запуск: метод запуска, вызванный для агента slavew56f680 25 мая 2018 15:54:56 com.microsoft.rest.interceptors.LoggingInterceptor log INFO: <- HTTP FAILED: java.net.SocketException: сброс соединения 25 мая 2018 15:54:56 PM okhttp3.internal.platform.Platform log INFO: Отменен обратный вызов ALPN: SPDY и HTTP /2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:54:56 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate isVMAliveOrHealthy INFO: AzureVMManagementServiceDelegate: isVMAliveOrHealthy: состояние PowerState / работает 25 мая 2018:54.AzureVMAgentSSHLauncher connectToSsh ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: connectToSsh: запуск 25 мая, 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher getRemoteSession ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: getRemoteSession: получение удаленного сеанса для ведомого пользователя для размещения slavew56f680.ukwest.cloudapp.azure8:22 3 мая 201: 54: 56 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher getRemoteSession INFO: AzureVMAgentSSHLauncher: getRemoteSession: получен удаленный сеанс для ведомого пользователя на хосте slavew56f680.ukwest.cloudapp.azure.com:54 25 мая: 201817:00 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher connectToSsh ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: connectToSsh: получено удаленное подключение 25 мая 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureMMAHerМашинаЗакрытьЗаключитьВозверить:: начальный каталог C: .azure-agent-init 25 мая 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher executeRemoteCommand INFO: AzureVMAgentSSHLauncher: executeRemoteCommand: выполнено успешно May 25, 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher INFO: AzureVMAgentSSHLauncher: запуск: проверка времени выполнения Java 25 мая 2018 15:54:56 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher executeRemoteCommand ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: executeRemoteCommand: запуск java -fullversion 25 мая 2018 г. 15:54:57 PM.54:57 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher Информация о запуске: AzureVMAgentSSHLauncher: запуск: присутствует среда выполнения java, копирование slave.jar в удаленный режим 25 мая 2018 15:54:57 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher copyFileToRemote INFO: AzureVMAgentSSHLauncher: copyFileToRemote: Инициирование передачи файла в slave.jar 25 мая 2018 15:55:07 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher копироватьSSHLauncher: copyFileToRemote: скопировал файл успешно в slave.jar 25 мая 2018 15:55:07 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher запустил INFO: AzureVMAgentSSHLauncher: запустил: агент запуска: java -jar slave.jar, 2018 15:55:07 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher INFO: AzureVMAgentSSHLauncher: запуск: успешно подключен 25 мая 2018 15:55:13 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher запускИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: запуск: запущенный агент успешно 25 мая 2018 15:57:13 com.squareup.okhttp.internal.Platform $ JdkWithJettyBootPlatform getSelectedProtocol INFO: обратный вызов ALPN удален: SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:57:18 com.squareup.okhttp.internal.Platform $ JdkWithJettyBootPlatform getSelectedProtocol ИНФОРМАЦИЯ: Отменен обратный вызов ALPN: SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:57:34 hudson.model.AsyncPeriodicWork $ 1 run INFO: Запущена задача очистки агентов виртуальной машины Azure 25 мая 2018 15:57:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask execute INFO: AzureVMAgentCleanUpTask execute:: начало 25 мая 2018 15:57:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask execute INFO: AzureVMAgentCleanUpTask: execute: запуск в чистом режиме с 5-минутным таймаутом 25 мая 2018 15:57:34 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanVMs ИНФОРМАЦИЯ: AzureVMAgentCleanUpTask: cleanVMs: узел slavew823810 заблокирован для очистки 25 мая 2018 3:57:34 вечера: 34:00 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask cleanDeployments INFO: AzureVMAgentCleanUpTask: cleanDeployments: Завершено развертывание очистки 25 мая 2018 15:57:34 PMcom.microsoft.rest.interceptors.LoggingInterceptor log INFO: <- HTTP FAILED: java.net.SocketException: сброс соединения 25 мая 2018 15:57:34 PM okhttp3.internal.platform.Platform log INFO: обратный вызов ALPN удален:SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 15:57:35 com.microsoft.azure.vmagent.AzureVMAgentCleanUpTask execute INFO: AzureVMAgentCleanUpTask: выполнить: конец 25 мая 2018 15:57:35 hudson.model.AsyncPeriodicWork $ 1 запустить INFO: завершенные агенты Azure VMЧистая задача.240 мс 25 мая 2018 15:59:09 запуск hudson.model.AsyncPeriodicWork $ 1 ИНФОРМАЦИЯ: Запуск пула сопровождающего виртуальной машины Azure 25 мая 2018 15:59:09 запуск hudson.model.AsyncPeriodicWork $ 1 ИНФОРМАЦИЯ: Закончено сопровождение виртуальной машины AzureРазмер бассейна.0 мс. 25 мая 2018 г. 15:59:15 PM.m.msoftsoft.azure.vmagent.AzureVMCloud предоставление ИНФОРМАЦИЯ: AzureVMCloud: предоставление: запуск для меток windows workLoad 1 мая 25, 2018 15:59:15 com.microsoft.azure.предоставление vmagent.AzureVMCloud INFO: AzureVMCloud: предоставление: проверка параметров повторного использования узла 25 мая 2018 15:59:15 PM com.microsoft.azure.vmagent.AzureVMCloud предоставление INFO: AzureVMCloud: предоставление: агентский компьютер, имеющий право на повторное использование slavew823810 25 мая,2018 15:59:15 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate virtualMachineExists ИНФОРМАЦИЯ: AzureVMManagementServiceDelegate: virtualMachineExists: проверка для slavew823810 25 мая 2018 15:59:15 com.microsoft.azure.MessageМагазинВерсияМагазинВерсияПредприятияМагазинВерсияМагазинВерсияМагазинМобЗаВМаЗаДвижения :ПредприятиеМагазинВерсияМагазинВерсияМагазинВерсииСредстваМождения :МагазинМагазин: КлиентМагазинаЗаследованияМагазинВерсияМагатаПредприятияМагазинВерсииСредстваПредставленияВозв |virtualMachineExists: slavew823810 существует 25 мая 2018 15:59:15 Предоставление com.microsoft.azure.vmagent.AzureVMCloud ИНФОРМАЦИЯ: AzureVMCloud: предоставление: асинхронное предоставление завершено, возвращение 1 запланированного узла (ей) 25 мая 2018 3:59: 15:00. Com.microsoft.azure.vmagent.AzureVMCloud $ 2 ИНФОРМАЦИЯ о вызове: найдено существующий узел, запускающий виртуальную машину slavew823810 25 мая 2018 г. 15:59:1525 мая 2018 15:59:15 org.jenkinsci.plugins.cloudstats.CloudStatistics logTypeNotSupported ИНФОРМАЦИЯ: Не поддерживается плагин cloud-stats для класса hudson.slaves.NodeProvisioner $ PlannedNode 25 мая 2018 15:59:15 hudson.slaves.NodeProvisioner $ StandardStrategyImpl apply INFO: Начата подготовка slavew823810 из Jenkins Azure Cloud с 1 исполнителем.Оставшаяся избыточная рабочая нагрузка: -0,282 25 мая 2018 г., 15:59:24метки = windows 25 мая 2018 15:59:24 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher launch INFO: AzureVMAgentSSHLauncher: launch: метод запуска вызван для агента slavew823810 25 мая 2018 15:59:48 com.microsoft.azure.vmagent.AzureVMManagementServiceDelegate isVMAliveOrHealthy INFO: AzureVMManagementServiceDelegate: isVMAliveOrHealthy: статус PowerState / работает 25 мая 2018 года, 3:59:48 вечера. com.microsoft.azure.3:59:48 вечера com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher getRemoteSession ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: getRemoteSession: получение удаленного сеанса для подчиненного пользователя вhost slavew823810.ukwest.cloudapp.azure.com:22 25 мая 2018 15:59:50 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher getRemoteSession ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: getRemoteSession: получен удаленный сеанс для подчиненного пользователя slavew38 на хост.ukwest.cloudapp.azure.com:22 25 мая 2018 15:59:50 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher connectToSsh ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: connectToSsh: получено удаленное соединение 25 мая 2018 15:59:50com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher executeRemoteCommand ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: executeRemoteCommand: начальный каталог C: .azure-agent-init-25 мая 2018 г., 15:59:51ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: executeRemoteCommand: успешно выполнено 25 мая 2018 15:59:51 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher запустится INFO: AzureVMAgentSSHLauncher: запуск: проверка наличия среды выполнения Java 25 мая 2018 15:59:51com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher executeRemoteCommand ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: executeRemoteCommand: запуск java -fullversion 25 мая 2018 г. 3:59:52выполнено успешно 25 мая 2018 15:59:52 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher запустите INFO: AzureVMAgentSSHLauncher: запуск: запуск javaнастоящее время, копирование slave.jar в удаленный режим 25 мая 2018 г. 15:59:52 com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher copyFileToRemote INFO: AzureVMAgentSSHLauncher: copyFileToRemote: инициирование передачи файла в slave.jar 25 мая 201 г.00:02 вечера com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher copyFileToRemote ИНФОРМАЦИЯ: AzureVMAgentSSHLauncher: copyFileToRemote: файл успешно скопирован в slave.jar 25 мая 2018 года, 4:00:02 вечера com.microsoft.azure.hmaИнформация о запуске: AzureVMAgentSSHLauncher: запуск: агент запуска: java -jar slave.jar 25 мая 2018 г. 16:00:02 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher запуск INFO: AzureVMAgentSSHLauncher: запуск: успешно подключен 25 мая 2018 г.16:00:13 PM com.microsoft.azure.vmagent.remote.AzureVMAgentSSHLauncher INFO: запуск: AzureVMAgentSSHLauncher: запуск: запущенный агент успешно 25 мая 2018 16:00:13 com.microsoft.azure.vmagent.AzureVMCloud $ 2 вызов INFO:Удалить приостановленный статус для node: slavew823810 25 мая 2018 г. 16:00:15 hudson.slaves.NodeProvisioner $ 2 запустите INFO: подготовка slavew823810 успешно завершена.Сейчас у нас 3 компьютера. 25 мая 2018 г. 16:00:31 com.squareup.okhttp.internal.Platform $ JdkWithJettyBootPlatform getSelectedProtocol ИНФОРМАЦИЯ: Отозван обратный вызов ALPN: SPDY и HTTP / 2 отключены.Находится ли alpn-boot на пути к классу загрузки?25 мая 2018 года, 16:00:44. Org.jenkinsci.plugins.workflow.job.WorkflowRun finish ИНФОРМАЦИЯ: tokio-utp / master # 29 завершено: НЕИСПРАВНОСТЬ </p>
Как видно изжурналы, в 3:47 я перезагрузил подчиненный узел "slavew56f680" вручную.
К 3:54 ведомый узел был снова запущен и запущен, поэтому я нажал, чтобы запустить агент, который успешно подключился (но в пользовательском интерфейсе этовсе еще говорит, что приостановлено).
В 3:57 я нажал, чтобы создать задание, ожидая, что приостановленное состояние будет удалено и задание будет запущено на этом ведомом устройстве.
В 3:59 Он переместилсяна другое ведомое устройство («slavew823810»), включите его и запустите на нем задание.
В этом конкретном примере slavew823810 был ведомым устройством Windows, с которым это происходило раньше, я просто никогда не удалял его и запускал его обратновверх.Если бы я удалил его, то он создал бы новую ведомую виртуальную машину Windows.
Кто-нибудь видел это раньше?Любая идея, как я могу остановить это или удалить приостановленный статус?
Версия Jenkins - 2.107.3 Мой master (Linux) и slave (Windows) оба находятся в Azure.
Заранее спасибо, Стивен.
Обновление
После того, как мои подчиненные были отключены в выходные, я запустил их в Azure, а затем, подключившись в Jenkins (но, говоря, приостановив), запустил задание сборки - в результате после долгой задержки он создал еще одну ведомую машину Windows для запуска задания.на.У меня сейчас 3 винды рабов.Я надеялся, что он будет использовать одну из двух предыдущих машин, и поэтому меня не заблокируют, так как они были обновлены с помощью необходимого мне дополнительного программного обеспечения и патчей.