Link to build:
https://uberchromegw.corp.google.com/i/chromeos_release/builders/x86-mario-release%20release-R56-9000.B/builds/8
Logs:
11/29 02:11:32.585 ERROR| base_utils:0280| [stderr] 2016-11-29 02:11:31 URL:http://100.115.185.226:8082/static/x86-mario-release/R56-9000.10.0/autotest/packages/client-autotest.tar.bz2 [11507583/11507583] -> "/tmp/sysinfo/autoserv-CO42xT/packages/client-autotest.tar.bz2" [1]
11/29 02:11:33.930 ERROR| base_utils:0280| [stderr] 2016-11-29 02:11:33 URL:http://100.115.185.226:8082/static/x86-mario-release/R56-9000.10.0/autotest/packages/packages.checksum [33928/33928] -> "/tmp/sysinfo/autoserv-CO42xT/packages.checksum" [1]
11/29 02:11:35.220 ERROR| base_utils:0280| [stderr] cat: /tmp/sysinfo/autoserv-CO42xT/.checksum: No such file or directory
11/29 02:13:45.667 ERROR| base_utils:0280| [stderr] mux_client_request_session: read from master failed: Broken pipe
11/29 02:13:54.730 ERROR| base_utils:0280| [stderr] [1129/021354:INFO:update_engine_client.cc(471)] Forcing an update by setting app_version to ForcedUpdate.
11/29 02:13:54.731 ERROR| base_utils:0280| [stderr] [1129/021354:INFO:update_engine_client.cc(473)] Initiating update check and install.
11/29 02:13:54.734 ERROR| base_utils:0280| [stderr] [1129/021354:INFO:update_engine_client.cc(502)] Waiting for update to complete.
11/29 02:23:18.723 ERROR| base_utils:0280| [stderr] [1129/022318:INFO:update_engine_client.cc(224)] Update succeeded -- reboot needed.
11/29 02:23:18.987 ERROR| base_utils:0280| [stderr] [1129/022318:INFO:update_engine_client.cc(493)] Querying Update Engine status...
11/29 02:26:54.782 ERROR| base_utils:0280| [stderr] mux_client_request_session: read from master failed: Broken pipe
11/29 02:27:03.343 ERROR| base_utils:0280| [stderr] 2016-11-29 02:27:02 URL:http://100.115.185.226:8082/static/x86-mario-release/R56-9000.10.0/autotest/packages/client-autotest.tar.bz2 [11507583/11507583] -> "/usr/local/autotest/packages/client-autotest.tar.bz2" [1]
11/29 02:27:05.659 ERROR| base_utils:0280| [stderr] 2016-11-29 02:27:04 URL:http://100.115.185.226:8082/static/x86-mario-release/R56-9000.10.0/autotest/packages/packages.checksum [33928/33928] -> "/usr/local/autotest/packages.checksum" [1]
11/29 02:27:07.053 ERROR| base_utils:0280| [stderr] cat: /usr/local/autotest/.checksum: No such file or directory
11/29 02:28:50.576 ERROR| base_utils:0280| [stderr] [1129/022850:INFO:update_engine_client.cc(473)] Initiating update check and install.
11/29 02:36:56.129 ERROR| base_utils:0280| [stderr] mux_client_request_session: read from master failed: Broken pipe
11/29 02:37:02.971 ERROR| base_utils:0280| [stderr] [1129/023702:INFO:update_engine_client.cc(473)] Initiating update check and install.
11/29 02:37:02.972 ERROR| base_utils:0280| [stderr] [1129/023702:ERROR:object_proxy.cc(582)] Failed to call method: org.chromium.UpdateEngineInterface.AttemptUpdateWithFlags: object_path= /org/chromium/UpdateEngine: org.freedesktop.DBus.Error.ServiceUnknown: The name org.chromium.UpdateEngine was not provided by any .service files
11/29 02:37:02.972 ERROR| base_utils:0280| [stderr] [1129/023702:ERROR:dbus_method_invoker.h(111)] CallMethodAndBlockWithTimeout(...): Domain=dbus, Code=org.freedesktop.DBus.Error.ServiceUnknown, Message=The name org.chromium.UpdateEngine was not provided by any .service files
11/29 02:37:02.972 ERROR| base_utils:0280| [stderr] [1129/023702:ERROR:update_engine_client.cc(476)] Error checking for update.
11/29 02:37:02.975 ERROR| autoupdater:0183| command execution error
* Command:
/usr/bin/ssh -a -x -o ControlPath=/tmp/_autotmp_3Wwp8Fssh-
master/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null
-o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=900 -o
ServerAliveCountMax=3 -o ConnectionAttempts=4 -o Protocol=2 -l root -p 22
chromeos6-row2-rack5-host22 "export LIBC_FATAL_STDERR_=1; if type
\"logger\" > /dev/null 2>&1; then logger -tag \"autotest\"
\"server[stack::trigger_update|trigger_update|_base_update_handler] ->
ssh_run(/usr/bin/update_engine_client --check_for_update
--omaha_url=http://100.115.185.226:40095/update)\";fi;
/usr/bin/update_engine_client --check_for_update
--omaha_url=http://100.115.185.226:40095/update"
Exit status: 1
Duration: 1.39874911308
Comment 1 by dshi@chromium.org
, Nov 29 2016The failure seems to be from update_engine File "/usr/local/autotest/server/hosts/ssh_host.py", line 154, in _run raise error.AutoservRunError("command execution error", result) AutoservRunError: command execution error * Command: /usr/bin/ssh -a -x -o ControlPath=/tmp/_autotmp_3Wwp8Fssh- master/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=900 -o ServerAliveCountMax=3 -o ConnectionAttempts=4 -o Protocol=2 -l root -p 22 chromeos6-row2-rack5-host22 "export LIBC_FATAL_STDERR_=1; if type \"logger\" > /dev/null 2>&1; then logger -tag \"autotest\" \"server[stack::trigger_update|trigger_update|_base_update_handler] -> ssh_run(/usr/bin/update_engine_client --check_for_update --omaha_url=http://100.115.185.226:40095/update)\";fi; /usr/bin/update_engine_client --check_for_update --omaha_url=http://100.115.185.226:40095/update" Exit status: 1 Duration: 1.39874911308 Basically, the command "update_engine_client --check_for_update" failed. If this is reproducible, likely there is some issue with update engine. Otherwise, it could be just some flake. Let's watch for the next build.