https://uberchromegw.corp.google.com/i/chromeos/builders/auron_paine-release/builds/596
https://pantheon.corp.google.com/storage/browser/chromeos-autotest-results/86855703-chromeos-test/chromeos4-row8-rack4-host4/debug/
11/22 14:27:30.882 DEBUG| abstract_ssh:0555| Host chromeos4-row8-rack4-host4 is now up
11/22 14:27:30.883 DEBUG| abstract_ssh:0337| get_file. source: /tmp/sysinfo/autoserv-dU7fIs/results/default/, dest: /usr/local/autotest/results/86855703-chromeos-test, delete_dest: False,preserve_perm: True, preserve_symlinks:True
11/22 14:27:30.883 DEBUG| abstract_ssh:0348| Using Rsync.
11/22 14:27:30.883 DEBUG| base_utils:0185| Running 'rsync --timeout=1800 --rsh='/usr/bin/ssh -a -x -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' -az --no-o --no-g root@chromeos4-row8-rack4-host4:"/tmp/sysinfo/autoserv-dU7fIs/results/default/" "/usr/local/autotest/results/86855703-chromeos-test"'
11/22 14:27:32.013 DEBUG| base_job:0246| Importing client.steps from state file /usr/local/autotest/results/86855703-chromeos-test/control.autoserv.state
11/22 14:27:32.013 DEBUG| base_job:0246| Importing client.harness from state file /usr/local/autotest/results/86855703-chromeos-test/control.autoserv.state
11/22 14:27:32.014 DEBUG| base_job:0243| Value of client.sysinfo is unchanged, skipping import
11/22 14:27:32.014 DEBUG| base_job:0246| Importing client._record_indent from state file /usr/local/autotest/results/86855703-chromeos-test/control.autoserv.state
11/22 14:27:32.014 DEBUG| base_job:0243| Value of global_properties.tag is unchanged, skipping import
11/22 14:27:32.014 DEBUG| base_job:0243| Value of global_properties.test_retry is unchanged, skipping import
11/22 14:27:32.015 DEBUG| base_job:0392| Persistent state client.* deleted
11/22 14:27:32.016 DEBUG| abstract_ssh:0337| get_file. source: /tmp/autoserv-LkBpta/sysinfo.pickle, dest: /tmp/tmpKPD0O0, delete_dest: False,preserve_perm: True, preserve_symlinks:False
11/22 14:27:32.016 DEBUG| abstract_ssh:0348| Using Rsync.
11/22 14:27:32.017 DEBUG| base_utils:0185| Running 'rsync -L --timeout=1800 --rsh='/usr/bin/ssh -a -x -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' -az --no-o --no-g root@chromeos4-row8-rack4-host4:"/tmp/autoserv-LkBpta/sysinfo.pickle" "/tmp/tmpKPD0O0"'
11/22 14:27:32.912 WARNI| test:0606| Autotest caught exception when running test:
Traceback (most recent call last):
File "/usr/local/autotest/client/common_lib/test.py", line 600, in _exec
_call_test_function(self.execute, *p_args, **p_dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 810, in _call_test_function
raise error.UnhandledTestFail(e)
UnhandledTestFail: Unhandled AutoservRunError: command execution error
* Command:
/usr/bin/ssh -a -x -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 chromeos4-row8-rack4-host4 "export
LIBC_FATAL_STDERR_=1; if type \"logger\" > /dev/null 2>&1; then logger
-tag \"autotest\" \"server[stack::get_kernel_tries|_cgpt|_run] ->
ssh_run(cgpt show -n -i 2 -T \\\$(rootdev -s -d))\";fi; cgpt show -n -i 2
-T \$(rootdev -s -d)"
Exit status: 255
Duration: 20.0872089863
stderr:
ssh: Could not resolve hostname chromeos4-row8-rack4-host4: Name or service not known
Traceback (most recent call last):
File "/usr/local/autotest/client/common_lib/test.py", line 804, in _call_test_function
return func(*args, **dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 461, in execute
dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 347, in _call_run_once_with_retry
postprocess_profiled_run, args, dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 376, in _call_run_once
self.run_once(*args, **dargs)
File "/usr/local/autotest/server/site_tests/autoupdate_Rollback/autoupdate_Rollback.py", line 50, in run_once
rollback_message=error_message)
File "/usr/local/autotest/client/common_lib/cros/autoupdater.py", line 703, in verify_boot_expectations
timeout=self.KERNEL_UPDATE_TIMEOUT, sleep_interval=5)
File "/usr/local/autotest/client/common_lib/site_utils.py", line 941, in poll_for_condition
value = condition()
File "/usr/local/autotest/client/common_lib/cros/autoupdater.py", line 700, in <lambda>
lambda: (self.get_kernel_tries(active_kernel_state) == 0
File "/usr/local/autotest/client/common_lib/cros/autoupdater.py", line 395, in get_kernel_tries
return self._cgpt('-T', kernel)
File "/usr/local/autotest/client/common_lib/cros/autoupdater.py", line 368, in _cgpt
kernel['kernel'], flag, dev)).stdout.strip())
File "/usr/local/autotest/client/common_lib/cros/autoupdater.py", line 341, in _run
return self.host.run(cmd, *args, **kwargs)
File "/usr/local/autotest/server/hosts/ssh_host.py", line 190, in run
options, stdin, args, ignore_timeout)
File "/usr/local/autotest/server/hosts/ssh_host.py", line 157, in _run
raise error.AutoservRunError("command execution error", result)
AutoservRunError: command execution error
It's very odd that chromeos4-row8-rack4-host4 resolution first seems to work fine at 11/22 14:27:30.883, then does not work anymore at 11/22 14:27:32.017...
Comment 1 by shuqianz@chromium.org
, Nov 23 2016Status: Duplicate (was: Untriaged)