Autotest with cellular_* failed

39 views
Skip to first unread message

Jarvis Jiang

unread,
Dec 9, 2021, 9:19:58 PM12/9/21
to Chromium OS Development
I am doing some cellular_* autotest, but all of them failed with "Unhandled ModuleNotFoundError: No module named 'gobject".

There is the output: 
$ test_that -b ${BOARD_CORAL} ro...@192.168.183.69 cellular_DisableWhileConnecting

NOTE: test_that.py switching to /usr/bin/python2.7
/usr/bin/python2.7: warning: Python 2.7 is deprecated and will be removed from CrOS by end of 2021. All users must migrate ASAP.
/usr/bin/python2.7: commandline: -u /mnt/host/source/src/third_party/autotest/files/site_utils/test_that.py -b coral ro...@192.168.183.69 cellular_DisableWhileConnecting
INFO:root:Identity added: /tmp/test_that_results_coral_OBG_DI/testing_rsa (/tmp/test_that_results_coral_OBG_DI/testing_rsa)
INFO:root:Model unspecified, attempting to determine model from host.
INFO:root:Starting main-ssh connection '/usr/bin/ssh -a -x -N -o ControlMaster=yes -o ControlPath=/tmp/ssh-main_mcs/_autotmp_Bmcg4C/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=30 -o ServerAliveCountMax=1 -o ConnectionAttempts=1 -o Protocol=2 -l root  192.168.183.69'
INFO:root:Attempting to autodetect if host is of type CrosHost
INFO:root:Starting main-ssh connection '/usr/bin/ssh -a -x -N -o ControlMaster=yes -o ControlPath=/tmp/ssh-main_mcs/_autotmp__EeIxt/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=30 -o ServerAliveCountMax=1 -o ConnectionAttempts=1 -o Protocol=2 -l root  192.168.183.69'
INFO:root:DUT is pingable before init Servo.
INFO:root:Starting main-ssh connection '/usr/bin/ssh -a -x -N -o ControlMaster=yes -o ControlPath=/tmp/ssh-main_mcs/_autotmp_Eifvum/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=30 -o ServerAliveCountMax=1 -o ConnectionAttempts=1 -o Protocol=2 -l root  192.168.183.69'
ERROR:root:[stderr] ls: cannot access '/usr/local/telemetry': No such file or directory
INFO:root:Detected host model: astronaut
17:32:15 INFO | Running autotest_quickmerge step.
17:32:23 INFO | quickmerge| 17:32:23.256: INFO: run: sudo -- /usr/bin/python3 /mnt/host/source/chromite/bin/autotest_quickmerge '--board=coral'
17:32:38 INFO | quickmerge| 17:32:38.078: INFO: run: rsync -a --no-p '--chmod=ugo=rwX' -u -i '--exclude=**.pyc' '--exclude=**.pyo' '--exclude=autotest_lib/' '--exclude=** -> *' '--include-from=/mnt/host/source/chromite/scripts/autotest-quickmerge-includepatterns' -L '--exclude=*' // /build/coral/usr/local/build/autotest/
17:32:38 INFO | quickmerge| 17:32:38.520: INFO: .d..t.og... ./
17:32:38 INFO | quickmerge|
17:32:38 INFO | quickmerge| 17:32:38.524: INFO: Updating portage database.
17:32:49 INFO | quickmerge| 17:32:49.676: INFO: run: rsync -a --no-p '--chmod=ugo=rwX' -u -i '--exclude=**.pyc' '--exclude=**.pyo' '--exclude=autotest_lib/' '--exclude=** -> *' '--include-from=/mnt/host/source/chromite/scripts/autotest-quickmerge-includepatterns' -L '--exclude=*' /mnt/host/source/src/third_party/autotest/files/ /build/coral/usr/local/build/autotest/
17:33:36 INFO | quickmerge| 17:33:36.327: INFO: .d..t.og... ./
17:33:36 INFO | quickmerge|
17:33:36 INFO | quickmerge| 17:33:36.328: INFO: Updating portage database.
17:33:37 INFO | quickmerge| 17:33:37.260: INFO: run: rsync -a --no-p '--chmod=ugo=rwX' -u -i '--exclude=**.pyc' '--exclude=**.pyo' '--exclude=** -> *' '--include-from=/mnt/host/source/chromite/scripts/autotest-quickmerge-includepatterns' -l /mnt/host/source/src/third_party/autotest/files/client/autotest_lib /build/coral/usr/local/build/autotest/client/
17:33:38 INFO | quickmerge| 17:33:38.245: INFO:
17:33:38 INFO | quickmerge| 17:33:38.246: INFO: Updating portage database.
17:33:39 INFO | quickmerge| 17:33:39.250: INFO: run: rsync -a --no-p '--chmod=ugo=rwX' -u -i '--exclude=**.pyc' '--exclude=**.pyo' '--exclude=** -> *' '--include-from=/mnt/host/source/chromite/scripts/autotest-quickmerge-includepatterns' -l /mnt/host/source/src/third_party/autotest/files/autotest_lib /build/coral/usr/local/build/autotest/
17:33:39 INFO | quickmerge| 17:33:39.484: INFO:
17:33:39 INFO | quickmerge| 17:33:39.485: INFO: Updating portage database.
17:33:41 INFO | quickmerge| 17:33:41.061: INFO: run: touch /build/coral/usr/local/build/autotest/.quickmerge_sentinel
17:33:41 INFO | quickmerge| 17:33:41.367: INFO: Quickmerge complete. Created or modified 0 files.
17:33:41 INFO | Re-running test_that script in /build/coral/usr/local/build/autotest copy of autotest.
NOTE: test_that.py switching to /usr/bin/python2.7
/usr/bin/python2.7: warning: Python 2.7 is deprecated and will be removed from CrOS by end of 2021. All users must migrate ASAP.
/usr/bin/python2.7: commandline: -u /build/coral/usr/local/build/autotest/site_utils/test_that.py --model=astronaut -b coral ro...@192.168.183.69 cellular_DisableWhileConnecting
INFO:root:Identity added: /tmp/test_that_results_coral_sd2mS8/testing_rsa (/tmp/test_that_results_coral_sd2mS8/testing_rsa)
17:34:16 INFO | Began logging to /tmp/test_that_results_coral_sd2mS8
17:34:16 INFO | Fetching suite for job named ...
17:35:55 INFO | Parsed 5659 child test control files.
17:35:55 INFO | Fetching suite for job named cellular_DisableWhileConnecting...
17:35:59 INFO | Parsed 5659 child test control files.
17:35:59 INFO | 1 jobs in job queue
17:35:59 INFO | autoserv| /usr/bin/python2.7: warning: Python 2.7 is deprecated and will be removed from CrOS by end of 2021. All users must migrate ASAP.
17:35:59 INFO | autoserv| /usr/bin/python2.7: commandline: /build/coral/usr/local/build/autotest/server/autoserv -p -r /tmp/test_that_results_coral_sd2mS8/results-1-cellular_DisableWhileConnecting --local-only-host-info True --host-info-subdir host_info_store -m ro...@192.168.183.69 --no_console_prefix -u autotest_system -l adhoc/cellular_DisableWhileConnecting -c --no_use_packaging --py_version 3 /tmp/tmpwGs0ZK --args  servo_host=localhost servo_port=9999
17:36:00 INFO | autoserv| WARNING:root:Python 3 in Autotest is experimental.
17:36:00 INFO | autoserv| NOTE: autoserv switching to /usr/bin/python3.6
17:36:14 INFO | autoserv| INFO:root:Docker API is not installed in this environment
17:36:14 INFO | autoserv| INFO:root:Docker API is not installed in this environment
17:36:14 INFO | autoserv| INFO:root:Docker API is not installed in this environment
17:36:17 INFO | autoserv| WARNING:py.warnings:/usr/lib64/python3.6/site-packages/django/utils/module_loading.py:1: DeprecationWarning: the imp module is deprecated in favour of importlib; see the module's documentation for alternative uses
17:36:17 INFO | autoserv|   import imp
17:36:17 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/model_logic.py:1392: DeprecationWarning: __class__ not set defining 'ModelWithHash' as <class 'autotest_lib.frontend.afe.model_logic.ModelWithHash'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class ModelWithHash(dbmodels.Model):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:236: DeprecationWarning: __class__ not set defining 'Drone' as <class 'autotest_lib.frontend.afe.models.Drone'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class Drone(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:268: DeprecationWarning: __class__ not set defining 'DroneSet' as <class 'autotest_lib.frontend.afe.models.DroneSet'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class DroneSet(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:366: DeprecationWarning: __class__ not set defining 'User' as <class 'autotest_lib.frontend.afe.models.User'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class User(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:478: DeprecationWarning: __class__ not set defining 'Host' as <class 'autotest_lib.frontend.afe.models.Host'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   model_logic.ModelWithAttributes):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:927: DeprecationWarning: __class__ not set defining 'HostAttribute' as <class 'autotest_lib.frontend.afe.models.HostAttribute'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class HostAttribute(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:973: DeprecationWarning: __class__ not set defining 'StaticHostAttribute' as <class 'autotest_lib.frontend.afe.models.StaticHostAttribute'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class StaticHostAttribute(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:1125: DeprecationWarning: __class__ not set defining 'AclGroup' as <class 'autotest_lib.frontend.afe.models.AclGroup'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class AclGroup(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:1357: DeprecationWarning: __class__ not set defining 'Job' as <class 'autotest_lib.frontend.afe.models.Job'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class Job(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:1856: DeprecationWarning: __class__ not set defining 'JobKeyval' as <class 'autotest_lib.frontend.afe.models.JobKeyval'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class JobKeyval(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:1915: DeprecationWarning: __class__ not set defining 'HostQueueEntry' as <class 'autotest_lib.frontend.afe.models.HostQueueEntry'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class HostQueueEntry(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:2145: DeprecationWarning: __class__ not set defining 'AbortedHostQueueEntry' as <class 'autotest_lib.frontend.afe.models.AbortedHostQueueEntry'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class AbortedHostQueueEntry(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:2163: DeprecationWarning: __class__ not set defining 'SpecialTask' as <class 'autotest_lib.frontend.afe.models.SpecialTask'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class SpecialTask(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:18 INFO | autoserv| WARNING:py.warnings:/build/coral/usr/local/build/autotest/autotest_lib/frontend/afe/models.py:2293: DeprecationWarning: __class__ not set defining 'StableVersion' as <class 'autotest_lib.frontend.afe.models.StableVersion'>. Was __classcell__ propagated to type.__new__?
17:36:18 INFO | autoserv|   class StableVersion(dbmodels.Model, model_logic.ModelExtensions):
17:36:18 INFO | autoserv|
17:36:19 INFO | autoserv| Results placed in /tmp/test_that_results_coral_sd2mS8/results-1-cellular_DisableWhileConnecting
17:36:19 INFO | autoserv| Logged pid 567 to /tmp/test_that_results_coral_sd2mS8/results-1-cellular_DisableWhileConnecting/.autoserv_execute
17:36:19 INFO | autoserv| Configuration file does not exist, ignoring: /etc/chrome-infra/ts-mon.json
17:36:19 INFO | autoserv| ts_mon monitoring has been explicitly disabled
17:36:19 INFO | autoserv| ts_mon was set up.
17:36:19 INFO | autoserv| I am PID 567
17:36:19 INFO | autoserv| Not checking if job_repo_url contains autotest packages on ['ro...@192.168.183.69']
17:36:19 INFO | autoserv| Processing control file
17:36:19 INFO | autoserv| Starting main-ssh connection '/usr/bin/ssh -a -x -N -o ControlMaster=yes -o ControlPath=/tmp/ssh-main_mcs/_autotmp_pe_kucsu/socket -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o BatchMode=yes -o ConnectTimeout=30 -o ServerAliveInterval=30 -o ServerAliveCountMax=1 -o ConnectionAttempts=1 -o Protocol=2 -l root  192.168.183.69'
17:36:21 INFO | autoserv| DUT is pingable before init Servo.
17:36:23 INFO | autoserv| [stderr] ls: cannot access '/usr/local/telemetry': No such file or directory
17:36:23 INFO | autoserv| INFO        ----        ----        kernel=4.4.293-21041-g66878b4d6ce6        timestamp=1639100183        localtime=Dec 09 17:36:23
17:36:24 INFO | autoserv| Installing autotest on 192.168.183.69
17:36:24 INFO | autoserv| Using installation dir /usr/local/autotest
17:36:26 INFO | autoserv| Installation of autotest completed from /build/coral/usr/local/build/autotest/autotest_lib/client/
17:36:26 INFO | autoserv| Installing updated global_config.ini.
17:36:28 INFO | autoserv| Executing /usr/local/autotest/bin/autotest /usr/local/autotest/control phase 0
17:36:29 INFO | autoserv| /usr/bin/python2: warning: Python 2.7 is deprecated and will be removed from CrOS by end of 2021. All users must migrate ASAP.
17:36:29 INFO | autoserv| /usr/bin/python2: commandline: /usr/local/autotest/bin/autotestd_monitor /usr/local/tmp/autoserv-hTnJxd 0 0 --py_version=3
17:36:29 INFO | autoserv| WARNING:root:Python 3 in Autotest is experimental.
17:36:29 INFO | autoserv| NOTE: autotestd_monitor switching to /usr/bin/python3.6
17:36:29 INFO | autoserv| Entered autotestd_monitor.
17:36:29 INFO | autoserv| Finished launching tail subprocesses.
17:36:29 INFO | autoserv| Finished waiting on autotestd to start.
17:36:30 INFO | autoserv| START        ----        ----        timestamp=1639100184        localtime=Dec 09 17:36:24
17:36:30 INFO | autoserv| END ABORT        ----        ----        timestamp=1639100184        localtime=Dec 09 17:36:24        Unhandled ModuleNotFoundError: No module named 'gobject'
17:36:30 INFO | autoserv| Got lock of exit_code_file.
17:36:30 INFO | autoserv| Released lock of exit_code_file and closed it.
17:36:30 INFO | autoserv| Client complete
17:36:31 INFO | autoserv| Finished processing control file
17:36:31 INFO | autoserv| No client dir to retrieve.
17:36:31 INFO | autoserv| Skipping crash dump/info collection as requested.
17:36:32 INFO | autoserv| [stderr] ls: cannot access '/usr/local/telemetry': No such file or directory
-----------------------------------------------------------------------------------------
/tmp/test_that_results_coral_sd2mS8/results-1-cellular_DisableWhileConnecting [  FAILED  ]
/tmp/test_that_results_coral_sd2mS8/results-1-cellular_DisableWhileConnecting   Reason Unknown
-----------------------------------------------------------------------------------------
Total PASS: 0/1 (0%)

Logging the data into test_report.html file.
17:36:33 INFO | Finished running tests. Results can be found in /tmp/test_that_results_coral_sd2mS8 or /tmp/test_that_latest

Thanks,
Jarvis
Reply all
Reply to author
Forward
0 new messages