ChromeOS:
R66-10451.0.0
What steps will reproduce the problem?
(1) Run enterprise_CFM_Sanity on Zako
What is the expected result?
autotest succeeds.
What happens instead?
autotest fails
https://pantheon.corp.google.com/storage/browser/chromeos-autotest-results/180507162-chromeos-test/chromeos1-row3-rack5-host6/enterprise_CFM_Sanity/debug/
03/02 13:18:42.606 INFO | packages:0207| Successfully fetched client-autotest.tar.bz2 from http://172.27.215.252:8082/static/zako-release/R66-10451.0.0/autotest/packages/client-autotest.tar.bz2
03/02 13:18:43.364 INFO | packages:0190| Fetching packages.checksum from http://172.27.215.252:8082/static/zako-release/R66-10451.0.0/autotest/packages to /tmp/sysinfo/autoserv-4e3Fom/packages.checksum
03/02 13:18:43.686 INFO | packages:0207| Successfully fetched packages.checksum from http://172.27.215.252:8082/static/zako-release/R66-10451.0.0/autotest/packages/packages.checksum
03/02 13:18:44.411 ERROR| utils:0282| [stderr] cat: /tmp/sysinfo/autoserv-4e3Fom/.checksum: No such file or directory
03/02 13:18:46.307 INFO | autotest:0382| Installation of autotest completed using the packaging system.
03/02 13:18:48.229 INFO | autotest:0275| Got job repo url from host attributes: http://172.27.215.252:8082/static/zako-release/R66-10451.0.0/autotest/packages
03/02 13:18:48.912 INFO | autotest:1003| Executing /tmp/sysinfo/autoserv-4e3Fom/bin/autotest /tmp/sysinfo/autoserv-4e3Fom/control phase 0
03/02 13:18:49.992 INFO | autotest:1369| Entered autotestd_monitor.
03/02 13:18:49.993 INFO | autotest:1369| Finished launching tail subprocesses.
03/02 13:18:49.993 INFO | autotest:1369| Finished waiting on autotestd to start.
03/02 13:18:50.111 INFO | server_job:0218| START ---- ---- timestamp=1520025529 localtime=Mar 02 13:18:49
03/02 13:18:50.175 INFO | server_job:0218| GOOD ---- sysinfo.iteration.before timestamp=1520025529 localtime=Mar 02 13:18:49
03/02 13:18:50.180 INFO | server_job:0218| END GOOD ---- ---- timestamp=1520025529 localtime=Mar 02 13:18:49
03/02 13:18:50.202 INFO | autotest:1369| Got lock of exit_code_file.
03/02 13:18:50.202 INFO | autotest:1369| Released lock of exit_code_file and closed it.
03/02 13:18:52.204 INFO | autotest:1369| Killing child processes.
03/02 13:18:52.208 INFO | autotest:1088| Client complete
03/02 13:20:37.760 INFO | autotest:0275| Got job repo url from host attributes: http://172.27.215.252:8082/static/zako-release/R66-10451.0.0/autotest/packages
03/02 13:20:38.300 INFO | autotest:1003| Executing /tmp/sysinfo/autoserv-4e3Fom/bin/autotest /tmp/sysinfo/autoserv-4e3Fom/control phase 0
03/02 13:20:39.198 INFO | autotest:1369| Entered autotestd_monitor.
03/02 13:20:39.198 INFO | autotest:1369| Finished launching tail subprocesses.
03/02 13:20:39.198 INFO | autotest:1369| Finished waiting on autotestd to start.
03/02 13:20:39.223 INFO | server_job:0218| START ---- ---- timestamp=1520025638 localtime=Mar 02 13:20:38
03/02 13:20:39.274 INFO | server_job:0218| GOOD ---- sysinfo.iteration.after timestamp=1520025638 localtime=Mar 02 13:20:38
03/02 13:20:39.278 INFO | server_job:0218| END GOOD ---- ---- timestamp=1520025638 localtime=Mar 02 13:20:38
03/02 13:20:39.302 INFO | autotest:1369| Got lock of exit_code_file.
03/02 13:20:39.302 INFO | autotest:1369| Released lock of exit_code_file and closed it.
03/02 13:20:41.304 INFO | autotest:1369| Killing child processes.
03/02 13:20:41.316 INFO | autotest:1088| Client complete
03/02 13:20:42.120 WARNI| test:0637| The test failed with the following exception
Traceback (most recent call last):
File "/usr/local/autotest/client/common_lib/test.py", line 631, in _exec
_call_test_function(self.execute, *p_args, **p_dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 831, in _call_test_function
return func(*args, **dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 495, in execute
dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 362, in _call_run_once_with_retry
postprocess_profiled_run, args, dargs)
File "/usr/local/autotest/client/common_lib/test.py", line 400, in _call_run_once
self.run_once(*args, **dargs)
File "/usr/local/autotest/server/site_tests/enterprise_CFM_Sanity/enterprise_CFM_Sanity.py", line 129, in run_once
% ', '.join(map(str, FAILED_TEST_LIST)))
TestFail: Test failed because of following reasons: Diagnostics failed
03/02 13:20:42.120 INFO | cfm_base_test:0095| Taking screenshot and saving under /usr/local/autotest/results/180507162-chromeos-test/enterprise_CFM_Sanity/debug...
03/02 13:20:42.130 INFO | cfm_base_test:0137| Copying file "/tmp/tmpiW0fyN-0.png" from client to "/usr/local/autotest/results/180507162-chromeos-test/enterprise_CFM_Sanity/debug/enterprise_CFM_Sanity.png"...
03/02 13:20:42.480 WARNI| abstract_ssh:0448| rsync status 23, retrying
03/02 13:20:42.658 WARNI| abstract_ssh:0455| trying scp, rsync failed: Command <rsync -L --timeout=1800 --rsh='/usr/bin/ssh -a -x -o Protocol=2 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=900 -o ServerAliveCountMax=3 -o ConnectionAttempts=4 -l root -p 22' -az --no-o --no-g root@chromeos1-row3-rack5-host6:"/tmp/tmpiW0fyN-0.png" "/usr/local/autotest/results/180507162-chromeos-test/enterprise_CFM_Sanity/debug/enterprise_CFM_Sanity.png"> failed, rc=23, Command returned non-zero exit status
* Command:
rsync -L --timeout=1800 --rsh='/usr/bin/ssh -a -x -o Protocol=2 -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes
-o ConnectTimeout=30 -o ServerAliveInterval=900 -o ServerAliveCountMax=3
-o ConnectionAttempts=4 -l root -p 22' -az --no-o --no-g
root@chromeos1-row3-rack5-host6:"/tmp/tmpiW0fyN-0.png"
"/usr/local/autotest/results/180507162-chromeos-
test/enterprise_CFM_Sanity/debug/enterprise_CFM_Sanity.png"
Exit status: 23
Duration: 0.172674894333
Comment 1 by benhenry@google.com
, Jan 10NextAction: 2019-07-09