Back to build
Raw log | Switch to full mode | Login

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpmScHkS.json --task-output-dir /b/s/w/ir/tmp/t/tmp_AY9ts --merge-script /b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpMF0mc_merge_script_log --merge-additional-args '[]' --build-properties '{"bot_id": "gce-trusty-e833d7b0-us-west1-b-1jgm", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556055819654955, "id": "8915350928808475344", "project": "chromium", "tags": ["build_address:luci.chromium.ci/chromeos-kevin-rel/6127", "builder:chromeos-kevin-rel", "buildset:commit/git/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080780991083070320", "scheduler_job_id:chromium/chromeos-kevin-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-kevin-rel", "buildnumber": 6127, "got_angle_revision": "83740f9795844dd947543e03fd9a69155054b79b", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "got_revision_cp": "refs/heads/master@{#653380}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "33a2e1abff72ef2a7955b2ee942286901c638544", "got_v8_revision_cp": "refs/heads/7.6.6@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.chromiumos", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa"}' --summary-json-file /b/s/w/ir/tmp/t/tmp0HKcTj.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpJ2DQ8Z.json in dir /b/s/w/ir/k: allow_subannotations: True cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpmScHkS.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp_AY9ts', '--merge-script', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpMF0mc_merge_script_log', '--merge-additional-args', '[]', '--build-properties', '{"bot_id": "gce-trusty-e833d7b0-us-west1-b-1jgm", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556055819654955, "id": "8915350928808475344", "project": "chromium", "tags": ["build_address:luci.chromium.ci/chromeos-kevin-rel/6127", "builder:chromeos-kevin-rel", "buildset:commit/git/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080780991083070320", "scheduler_job_id:chromium/chromeos-kevin-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-kevin-rel", "buildnumber": 6127, "got_angle_revision": "83740f9795844dd947543e03fd9a69155054b79b", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "got_revision_cp": "refs/heads/master@{#653380}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "33a2e1abff72ef2a7955b2ee942286901c638544", "got_v8_revision_cp": "refs/heads/7.6.6@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.chromiumos", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa"}', '--summary-json-file', '/b/s/w/ir/tmp/t/tmp0HKcTj.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpJ2DQ8Z.json'] env: {'CHROME_HEADLESS': '1'} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('cros_vm_sanity_test on ChromeOS',) ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: () full environment: BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 34397 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915350928808475344 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/it4YCaZK/luci_context.856552030 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t MAIL: /var/mail/chrome-bot NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SUDO_COMMAND: /usr/bin/python /b/s/swarming_bot.zip start_bot SUDO_GID: 0 SUDO_UID: 0 SUDO_USER: root SWARMING_BOT_ID: gce-trusty-e833d7b0-us-west1-b-1jgm SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4464f911b9fb6111 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TERM: linux TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython _: /b/s/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-23 14:51:12,780 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmp_AY9ts' 2019-04-23 14:51:12,781 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmp_AY9ts' already exists! 2019-04-23 14:51:12,781 - root: [WARNING] task_output_dir existing content: [] 2019-04-23 14:51:12,781 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpJ2DQ8Z.json -output-dir /b/s/w/ir/tmp/t/tmp_AY9ts -task-summary-json /b/s/w/ir/tmp/t/tmp0HKcTj.json [D2019-04-23T14:51:12.788743-07:00 12874 0 auth.go:1265] Minting a new token {"key":"luci_ctx/0ea8298d6aeed0cafadeb61e427e176f56259eef6b81b3ff4f42092658fcdf9b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-23T14:51:12.788808-07:00 12874 0 luci_ctx.go:138] POST http://127.0.0.1:37172/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/0ea8298d6aeed0cafadeb61e427e176f56259eef6b81b3ff4f42092658fcdf9b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-23T14:51:12.790756-07:00 12874 0 auth.go:1222] Token expires in 30m5.209259658s {"key":"luci_ctx/0ea8298d6aeed0cafadeb61e427e176f56259eef6b81b3ff4f42092658fcdf9b", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 4464fed966c6c810: exit 0 /b/swarming/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown. Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: bin/run_cros_vm_sanity_test --vm-logs-dir=/b/swarming/w/ioelfl5j --test-launcher-summary-output=/b/swarming/w/ioelfl5j/output.json INFO:root:Running the following command on the device: INFO:root: #!/bin/sh export HOME=/tmp /usr/local/autotest/bin/vm_sanity.py INFO:root:Running the following command on the device: INFO:root:/b/swarming/w/ir/third_party/chromite/bin/cros_run_test --board kevin --cache-dir /b/swarming/w/ir/build/cros_cache --device variable_chromeos_device_hostname --results-src /var/log/ --results-dest-dir /b/swarming/w/ioelfl5j --nostrip --remote-cmd --cwd out_kevin/Release --files out_kevin/Release/tmpbkmp3K.sh --deploy --mount --build-dir out_kevin/Release -- ./tmpbkmp3K.sh INFO:root:######################################## INFO:root:Test attempt #0 INFO:root:######################################## 21:50:15: INFO: RunCommand: ssh -p 22 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- true 21:50:15: INFO: RunCommand: deploy_chrome --force --build-dir /b/swarming/w/ir/out_kevin/Release --process-timeout 180 --to variable_chromeos_device_hostname --board kevin --cache-dir /b/swarming/w/ir/build/cros_cache --nostrip --mount 21:50:16: INFO: Staging flags taken from USE in environment: highdpi 21:50:16: INFO: Preparing device 21:50:16: INFO: Testing connection to the device... 21:50:16: INFO: Shutting down Chrome... 21:50:17: INFO: Mounting Chrome... 21:50:18: INFO: Copying Chrome to /mnt/stateful_partition/deploy_rootfs/opt/google/chrome on device... 21:50:18: INFO: [mode:rsync] copy: /b/swarming/w/itXOCSnJ/tmpw9Hzhg/chrome/ -> variable_chromeos_device_hostname:/mnt/stateful_partition/deploy_rootfs/opt/google/chrome 21:50:18: INFO: Using rsync compression: False sending incremental file list chrome chrome-wrapper libmojo_core.so libmojo_core_arc32.so libmojo_core_arc64.so nacl_helper nacl_helper_bootstrap natives_blob.bin product_logo_48.png resources.pak snapshot_blob.bin xdg-settings dbus/org.chromium.ChromeFeaturesService.conf dbus/org.chromium.ComponentUpdaterService.conf dbus/org.chromium.DisplayService.conf dbus/org.chromium.DriveFileStreamService.conf dbus/org.chromium.KioskAppService.conf dbus/org.chromium.LibvdaService.conf dbus/org.chromium.LivenessService.conf dbus/org.chromium.MetricsEventService.conf dbus/org.chromium.NetworkProxyService.conf dbus/org.chromium.PluginVmService.conf dbus/org.chromium.ScreenLockService.conf dbus/org.chromium.UrlHandlerService.conf dbus/org.chromium.VirtualFileRequestService.conf dbus/org.chromium.VmApplicationsService.conf locales/en-US.pak locales/fr.pak pnacl/pnacl_public_arm_crtbegin_o pnacl/pnacl_public_arm_crtend_o pnacl/pnacl_public_arm_libcrt_platform_a pnacl/pnacl_public_arm_libgcc_a pnacl/pnacl_public_arm_libpnacl_irt_shim_a pnacl/pnacl_public_pnacl_json resources/chromeos/braille_ime/manifest.json resources/chromeos/camera/manifest.json resources/chromeos/camera/_locales/am/messages.json resources/chromeos/camera/_locales/ar/messages.json resources/chromeos/camera/_locales/bg/messages.json resources/chromeos/camera/_locales/bn/messages.json resources/chromeos/camera/_locales/ca/messages.json resources/chromeos/camera/_locales/cs/messages.json resources/chromeos/camera/_locales/da/messages.json resources/chromeos/camera/_locales/de/messages.json resources/chromeos/camera/_locales/el/messages.json resources/chromeos/camera/_locales/en/messages.json resources/chromeos/camera/_locales/en_GB/messages.json resources/chromeos/camera/_locales/es/messages.json resources/chromeos/camera/_locales/es_419/messages.json resources/chromeos/camera/_locales/et/messages.json resources/chromeos/camera/_locales/fa/messages.json resources/chromeos/camera/_locales/fi/messages.json resources/chromeos/camera/_locales/fil/messages.json resources/chromeos/camera/_locales/fr/messages.json resources/chromeos/camera/_locales/gu/messages.json resources/chromeos/camera/_locales/he/messages.json resources/chromeos/camera/_locales/hi/messages.json resources/chromeos/camera/_locales/hr/messages.json resources/chromeos/camera/_locales/hu/messages.json resources/chromeos/camera/_locales/id/messages.json resources/chromeos/camera/_locales/it/messages.json resources/chromeos/camera/_locales/ja/messages.json resources/chromeos/camera/_locales/kn/messages.json resources/chromeos/camera/_locales/ko/messages.json resources/chromeos/camera/_locales/lt/messages.json resources/chromeos/camera/_locales/lv/messages.json resources/chromeos/camera/_locales/ml/messages.json resources/chromeos/camera/_locales/mr/messages.json resources/chromeos/camera/_locales/ms/messages.json resources/chromeos/camera/_locales/nb/messages.json resources/chromeos/camera/_locales/nl/messages.json resources/chromeos/camera/_locales/pl/messages.json resources/chromeos/camera/_locales/pt_BR/messages.json resources/chromeos/camera/_locales/pt_PT/messages.json resources/chromeos/camera/_locales/ro/messages.json resources/chromeos/camera/_locales/ru/messages.json resources/chromeos/camera/_locales/sk/messages.json resources/chromeos/camera/_locales/sl/messages.json resources/chromeos/camera/_locales/sr/messages.json resources/chromeos/camera/_locales/sv/messages.json resources/chromeos/camera/_locales/sw/messages.json resources/chromeos/camera/_locales/ta/messages.json resources/chromeos/camera/_locales/te/messages.json resources/chromeos/camera/_locales/th/messages.json resources/chromeos/camera/_locales/tr/messages.json resources/chromeos/camera/_locales/uk/messages.json resources/chromeos/camera/_locales/vi/messages.json resources/chromeos/camera/_locales/zh_CN/messages.json resources/chromeos/camera/_locales/zh_TW/messages.json resources/chromeos/camera/css/main.css resources/chromeos/camera/images/browser_button_back.svg resources/chromeos/camera/images/browser_button_delete.svg resources/chromeos/camera/images/browser_button_export.svg resources/chromeos/camera/images/browser_button_print.svg resources/chromeos/camera/images/camera_app_icons_128.png resources/chromeos/camera/images/camera_app_icons_48.png resources/chromeos/camera/images/camera_button_grid_off.svg resources/chromeos/camera/images/camera_button_grid_on.svg resources/chromeos/camera/images/camera_button_mic_off.svg resources/chromeos/camera/images/camera_button_mic_on.svg resources/chromeos/camera/images/camera_button_mirror_off.svg resources/chromeos/camera/images/camera_button_mirror_on.svg resources/chromeos/camera/images/camera_button_settings.svg resources/chromeos/camera/images/camera_button_switch_device.svg resources/chromeos/camera/images/camera_button_switch_photo.svg resources/chromeos/camera/images/camera_button_switch_video.svg resources/chromeos/camera/images/camera_button_timer_off.svg resources/chromeos/camera/images/camera_button_timer_on_10s.svg resources/chromeos/camera/images/camera_button_timer_on_3s.svg resources/chromeos/camera/images/camera_focus_aim.svg resources/chromeos/camera/images/camera_mode_photo.svg resources/chromeos/camera/images/camera_mode_portrait.svg resources/chromeos/camera/images/camera_mode_square.svg resources/chromeos/camera/images/camera_mode_video.svg resources/chromeos/camera/images/camera_shutter_photo_start.svg resources/chromeos/camera/images/camera_shutter_photo_start_active.svg resources/chromeos/camera/images/camera_shutter_photo_start_hover.svg resources/chromeos/camera/images/camera_shutter_photo_stop.svg resources/chromeos/camera/images/camera_shutter_photo_stop_hover.svg resources/chromeos/camera/images/camera_shutter_video_start.svg resources/chromeos/camera/images/camera_shutter_video_start_hover.svg resources/chromeos/camera/images/camera_shutter_video_stop.svg resources/chromeos/camera/images/camera_shutter_video_stop_hover.svg resources/chromeos/camera/images/settings_button_back.svg resources/chromeos/camera/images/settings_button_expand.svg resources/chromeos/camera/images/settings_feedback.svg resources/chromeos/camera/images/settings_grid_type.svg resources/chromeos/camera/images/settings_help.svg resources/chromeos/camera/images/settings_timer_duration.svg resources/chromeos/camera/images/spinner.svg resources/chromeos/camera/js/background.js resources/chromeos/camera/js/gallerybutton.js resources/chromeos/camera/js/google-analytics-bundle.js resources/chromeos/camera/js/main.js resources/chromeos/camera/js/metrics.js resources/chromeos/camera/js/nav.js resources/chromeos/camera/js/scrollbar.js resources/chromeos/camera/js/sound.js resources/chromeos/camera/js/state.js resources/chromeos/camera/js/toast.js resources/chromeos/camera/js/tooltip.js resources/chromeos/camera/js/util.js resources/chromeos/camera/js/models/filenamer.js resources/chromeos/camera/js/models/filesystem.js resources/chromeos/camera/js/models/gallery.js resources/chromeos/camera/js/mojo/cros_image_capture.mojom-lite.js resources/chromeos/camera/js/mojo/image_capture.mojom-lite.js resources/chromeos/camera/js/mojo/imagecapture.js resources/chromeos/camera/js/mojo/mojo_bindings_lite.js resources/chromeos/camera/js/views/browser.js resources/chromeos/camera/js/views/camera.js resources/chromeos/camera/js/views/dialog.js resources/chromeos/camera/js/views/gallery_base.js resources/chromeos/camera/js/views/settings.js resources/chromeos/camera/js/views/view.js resources/chromeos/camera/js/views/warning.js resources/chromeos/camera/js/views/camera/layout.js resources/chromeos/camera/js/views/camera/modes.js resources/chromeos/camera/js/views/camera/options.js resources/chromeos/camera/js/views/camera/preview.js resources/chromeos/camera/js/views/camera/recordtime.js resources/chromeos/camera/js/views/camera/timertick.js resources/chromeos/camera/sounds/record_end.ogg resources/chromeos/camera/sounds/record_start.ogg resources/chromeos/camera/sounds/shutter.ogg resources/chromeos/camera/sounds/tick.ogg resources/chromeos/camera/views/main.html resources/chromeos/chromevox/chromeVox2ChromeBackgroundScript.js resources/chromeos/chromevox/chromeVox2ChromePageScript.js resources/chromeos/chromevox/chromeVoxChromeOptionsScript.js resources/chromeos/chromevox/chromeVoxChromePageScript.js resources/chromeos/chromevox/chromeVoxKbExplorerScript.js resources/chromeos/chromevox/chromeVoxLogScript.js resources/chromeos/chromevox/chromeVoxPanelScript.js resources/chromeos/chromevox/manifest.json resources/chromeos/chromevox/manifest_guest.json resources/chromeos/chromevox/_locales/am/messages.json resources/chromeos/chromevox/_locales/ar/messages.json resources/chromeos/chromevox/_locales/bg/messages.json resources/chromeos/chromevox/_locales/bn/messages.json resources/chromeos/chromevox/_locales/ca/messages.json resources/chromeos/chromevox/_locales/cs/messages.json resources/chromeos/chromevox/_locales/da/messages.json resources/chromeos/chromevox/_locales/de/messages.json resources/chromeos/chromevox/_locales/el/messages.json resources/chromeos/chromevox/_locales/en/messages.json resources/chromeos/chromevox/_locales/en_GB/messages.json resources/chromeos/chromevox/_locales/es/messages.json resources/chromeos/chromevox/_locales/es_419/messages.json resources/chromeos/chromevox/_locales/et/messages.json resources/chromeos/chromevox/_locales/fa/messages.json resources/chromeos/chromevox/_locales/fi/messages.json resources/chromeos/chromevox/_locales/fil/messages.json resources/chromeos/chromevox/_locales/fr/messages.json resources/chromeos/chromevox/_locales/gu/messages.json resources/chromeos/chromevox/_locales/he/messages.json resources/chromeos/chromevox/_locales/hi/messages.json resources/chromeos/chromevox/_locales/hr/messages.json resources/chromeos/chromevox/_locales/hu/messages.json resources/chromeos/chromevox/_locales/id/messages.json resources/chromeos/chromevox/_locales/it/messages.json resources/chromeos/chromevox/_locales/ja/messages.json resources/chromeos/chromevox/_locales/kn/messages.json resources/chromeos/chromevox/_locales/ko/messages.json resources/chromeos/chromevox/_locales/lt/messages.json resources/chromeos/chromevox/_locales/lv/messages.json resources/chromeos/chromevox/_locales/ml/messages.json resources/chromeos/chromevox/_locales/mr/messages.json resources/chromeos/chromevox/_locales/ms/messages.json resources/chromeos/chromevox/_locales/nb/messages.json resources/chromeos/chromevox/_locales/nl/messages.json resources/chromeos/chromevox/_locales/pl/messages.json resources/chromeos/chromevox/_locales/pt_BR/messages.json resources/chromeos/chromevox/_locales/pt_PT/messages.json resources/chromeos/chromevox/_locales/ro/messages.json resources/chromeos/chromevox/_locales/ru/messages.json resources/chromeos/chromevox/_locales/sk/messages.json resources/chromeos/chromevox/_locales/sl/messages.json resources/chromeos/chromevox/_locales/sr/messages.json resources/chromeos/chromevox/_locales/sv/messages.json resources/chromeos/chromevox/_locales/sw/messages.json resources/chromeos/chromevox/_locales/ta/messages.json resources/chromeos/chromevox/_locales/te/messages.json resources/chromeos/chromevox/_locales/th/messages.json resources/chromeos/chromevox/_locales/tr/messages.json resources/chromeos/chromevox/_locales/uk/messages.json resources/chromeos/chromevox/_locales/vi/messages.json resources/chromeos/chromevox/_locales/zh_CN/messages.json resources/chromeos/chromevox/_locales/zh_TW/messages.json resources/chromeos/chromevox/braille/liblouis_wasm.js resources/chromeos/chromevox/braille/liblouis_wasm.wasm resources/chromeos/chromevox/braille/liblouis_wrapper.js resources/chromeos/chromevox/braille/tables.json resources/chromeos/chromevox/chromevox/background/background.html resources/chromeos/chromevox/chromevox/background/checked.png resources/chromeos/chromevox/chromevox/background/kbexplorer.html resources/chromeos/chromevox/chromevox/background/options.css resources/chromeos/chromevox/chromevox/background/options.html resources/chromeos/chromevox/chromevox/background/unchecked.png resources/chromeos/chromevox/chromevox/background/earcons/alert_modal.ogg resources/chromeos/chromevox/chromevox/background/earcons/alert_nonmodal.ogg resources/chromeos/chromevox/chromevox/background/earcons/button.ogg resources/chromeos/chromevox/chromevox/background/earcons/check_off.ogg resources/chromeos/chromevox/chromevox/background/earcons/check_on.ogg resources/chromeos/chromevox/chromevox/background/earcons/editable_text.ogg resources/chromeos/chromevox/chromevox/background/earcons/invalid_keypress.ogg resources/chromeos/chromevox/chromevox/background/earcons/link.ogg resources/chromeos/chromevox/chromevox/background/earcons/list_item.ogg resources/chromeos/chromevox/chromevox/background/earcons/listbox.ogg resources/chromeos/chromevox/chromevox/background/earcons/long_desc.ogg resources/chromeos/chromevox/chromevox/background/earcons/math.ogg resources/chromeos/chromevox/chromevox/background/earcons/object_close.ogg resources/chromeos/chromevox/chromevox/background/earcons/object_enter.ogg resources/chromeos/chromevox/chromevox/background/earcons/object_exit.ogg resources/chromeos/chromevox/chromevox/background/earcons/object_open.ogg resources/chromeos/chromevox/chromevox/background/earcons/object_select.ogg resources/chromeos/chromevox/chromevox/background/earcons/page_finish_loading.ogg resources/chromeos/chromevox/chromevox/background/earcons/page_start_loading.ogg resources/chromeos/chromevox/chromevox/background/earcons/recover_focus.ogg resources/chromeos/chromevox/chromevox/background/earcons/selection.ogg resources/chromeos/chromevox/chromevox/background/earcons/selection_reverse.ogg resources/chromeos/chromevox/chromevox/background/earcons/skip.ogg resources/chromeos/chromevox/chromevox/background/earcons/wrap.ogg resources/chromeos/chromevox/chromevox/background/earcons/wrap_edge.ogg resources/chromeos/chromevox/chromevox/background/keymaps/classic_keymap.json resources/chromeos/chromevox/chromevox/background/keymaps/experimental.json resources/chromeos/chromevox/chromevox/background/keymaps/flat_keymap.json resources/chromeos/chromevox/chromevox/background/keymaps/next_keymap.json resources/chromeos/chromevox/chromevox/injected/api.js resources/chromeos/chromevox/chromevox/injected/mathjax.js resources/chromeos/chromevox/chromevox/injected/mathjax_external_util.js resources/chromeos/chromevox/cvox2/background/background.html resources/chromeos/chromevox/cvox2/background/log.css resources/chromeos/chromevox/cvox2/background/log.html resources/chromeos/chromevox/cvox2/background/panel.css resources/chromeos/chromevox/cvox2/background/panel.html resources/chromeos/chromevox/cvox2/background/sre_browser.js resources/chromeos/chromevox/cvox2/background/earcons/control.wav resources/chromeos/chromevox/cvox2/background/earcons/selection.wav resources/chromeos/chromevox/cvox2/background/earcons/selection_reverse.wav resources/chromeos/chromevox/cvox2/background/earcons/skim.wav resources/chromeos/chromevox/cvox2/background/earcons/small_room_2.wav resources/chromeos/chromevox/cvox2/background/earcons/static.wav resources/chromeos/chromevox/images/chromevox-128.png resources/chromeos/chromevox/images/chromevox-16.png resources/chromeos/chromevox/images/chromevox-19.png resources/chromeos/chromevox/images/chromevox-48.png resources/chromeos/chromevox/images/chromevox.svg resources/chromeos/chromevox/images/close-19.png resources/chromeos/chromevox/images/close-hover-19.png resources/chromeos/chromevox/images/options-19.png resources/chromeos/chromevox/images/options-hover-19.png resources/chromeos/chromevox/images/triangle-6.png resources/chromeos/select_to_speak/automation_predicate.js resources/chromeos/select_to_speak/automation_util.js resources/chromeos/select_to_speak/checked.png resources/chromeos/select_to_speak/closure_shim.js resources/chromeos/select_to_speak/constants.js resources/chromeos/select_to_speak/input_handler.js resources/chromeos/select_to_speak/manifest.json resources/chromeos/select_to_speak/manifest_guest.json resources/chromeos/select_to_speak/metrics_utils.js resources/chromeos/select_to_speak/node_utils.js resources/chromeos/select_to_speak/options.css resources/chromeos/select_to_speak/options.html resources/chromeos/select_to_speak/paragraph_utils.js resources/chromeos/select_to_speak/prefs_manager.js resources/chromeos/select_to_speak/rect_utils.js resources/chromeos/select_to_speak/select_to_speak-2x.svg resources/chromeos/select_to_speak/select_to_speak.js resources/chromeos/select_to_speak/select_to_speak_gdocs_script.js resources/chromeos/select_to_speak/select_to_speak_main.js resources/chromeos/select_to_speak/select_to_speak_options.js resources/chromeos/select_to_speak/tree_walker.js resources/chromeos/select_to_speak/unchecked.png resources/chromeos/select_to_speak/word_utils.js resources/chromeos/select_to_speak/_locales/am/messages.json resources/chromeos/select_to_speak/_locales/ar/messages.json resources/chromeos/select_to_speak/_locales/bg/messages.json resources/chromeos/select_to_speak/_locales/bn/messages.json resources/chromeos/select_to_speak/_locales/ca/messages.json resources/chromeos/select_to_speak/_locales/cs/messages.json resources/chromeos/select_to_speak/_locales/da/messages.json resources/chromeos/select_to_speak/_locales/de/messages.json resources/chromeos/select_to_speak/_locales/el/messages.json resources/chromeos/select_to_speak/_locales/en/messages.json resources/chromeos/select_to_speak/_locales/en_GB/messages.json resources/chromeos/select_to_speak/_locales/es/messages.json resources/chromeos/select_to_speak/_locales/es_419/messages.json resources/chromeos/select_to_speak/_locales/et/messages.json resources/chromeos/select_to_speak/_locales/fa/messages.json resources/chromeos/select_to_speak/_locales/fi/messages.json resources/chromeos/select_to_speak/_locales/fil/messages.json resources/chromeos/select_to_speak/_locales/fr/messages.json resources/chromeos/select_to_speak/_locales/gu/messages.json resources/chromeos/select_to_speak/_locales/he/messages.json resources/chromeos/select_to_speak/_locales/hi/messages.json resources/chromeos/select_to_speak/_locales/hr/messages.json resources/chromeos/select_to_speak/_locales/hu/messages.json resources/chromeos/select_to_speak/_locales/id/messages.json resources/chromeos/select_to_speak/_locales/it/messages.json resources/chromeos/select_to_speak/_locales/ja/messages.json resources/chromeos/select_to_speak/_locales/kn/messages.json resources/chromeos/select_to_speak/_locales/ko/messages.json resources/chromeos/select_to_speak/_locales/lt/messages.json resources/chromeos/select_to_speak/_locales/lv/messages.json resources/chromeos/select_to_speak/_locales/ml/messages.json resources/chromeos/select_to_speak/_locales/mr/messages.json resources/chromeos/select_to_speak/_locales/ms/messages.json resources/chromeos/select_to_speak/_locales/nb/messages.json resources/chromeos/select_to_speak/_locales/nl/messages.json resources/chromeos/select_to_speak/_locales/pl/messages.json resources/chromeos/select_to_speak/_locales/pt_BR/messages.json resources/chromeos/select_to_speak/_locales/pt_PT/messages.json resources/chromeos/select_to_speak/_locales/ro/messages.json resources/chromeos/select_to_speak/_locales/ru/messages.json resources/chromeos/select_to_speak/_locales/sk/messages.json resources/chromeos/select_to_speak/_locales/sl/messages.json resources/chromeos/select_to_speak/_locales/sr/messages.json resources/chromeos/select_to_speak/_locales/sv/messages.json resources/chromeos/select_to_speak/_locales/sw/messages.json resources/chromeos/select_to_speak/_locales/ta/messages.json resources/chromeos/select_to_speak/_locales/te/messages.json resources/chromeos/select_to_speak/_locales/th/messages.json resources/chromeos/select_to_speak/_locales/tr/messages.json resources/chromeos/select_to_speak/_locales/uk/messages.json resources/chromeos/select_to_speak/_locales/vi/messages.json resources/chromeos/select_to_speak/_locales/zh_CN/messages.json resources/chromeos/select_to_speak/_locales/zh_TW/messages.json resources/chromeos/select_to_speak/earcons/null_selection.ogg resources/chromeos/switch_access/auto_scan_manager.js resources/chromeos/switch_access/back_button_manager.js resources/chromeos/switch_access/background.js resources/chromeos/switch_access/closure_shim.js resources/chromeos/switch_access/commands.js resources/chromeos/switch_access/constants.js resources/chromeos/switch_access/key_event_handler.js resources/chromeos/switch_access/keyboard_handler.js resources/chromeos/switch_access/manifest.json resources/chromeos/switch_access/manifest_guest.json resources/chromeos/switch_access/menu_manager.js resources/chromeos/switch_access/menu_panel.css resources/chromeos/switch_access/menu_panel.html resources/chromeos/switch_access/menu_panel.js resources/chromeos/switch_access/menu_panel_interface.js resources/chromeos/switch_access/navigation_manager.js resources/chromeos/switch_access/options.css resources/chromeos/switch_access/options.html resources/chromeos/switch_access/options.js resources/chromeos/switch_access/preferences.js resources/chromeos/switch_access/prefs.js resources/chromeos/switch_access/switch_access.js resources/chromeos/switch_access/switch_access_constants.js resources/chromeos/switch_access/switch_access_predicate.js resources/chromeos/switch_access/text_input_manager.js resources/chromeos/switch_access/tree_walker.js resources/chromeos/switch_access/closure/base.js resources/chromeos/switch_access/icons/back.svg resources/chromeos/switch_access/icons/decrement.svg resources/chromeos/switch_access/icons/dictation.svg resources/chromeos/switch_access/icons/increment.svg resources/chromeos/switch_access/icons/keyboard.svg resources/chromeos/switch_access/icons/options.svg resources/chromeos/switch_access/icons/scrollDownOrForward.svg resources/chromeos/switch_access/icons/scrollLeft.svg resources/chromeos/switch_access/icons/scrollRight.svg resources/chromeos/switch_access/icons/scrollUpOrBackward.svg resources/chromeos/switch_access/icons/select.svg resources/chromeos/switch_access/icons/showContextMenu.svg resources/chromeos/zip_archiver/manifest.json resources/chromeos/zip_archiver/module.nmf resources/chromeos/zip_archiver/zip_archiver_pnacl.pexe resources/chromeos/zip_archiver/css/passphrase.css resources/chromeos/zip_archiver/html/passphrase-dialog.html resources/chromeos/zip_archiver/html/passphrase.html resources/chromeos/zip_archiver/icons/icon128.png resources/chromeos/zip_archiver/icons/icon16.png resources/chromeos/zip_archiver/icons/icon32.png resources/chromeos/zip_archiver/icons/icon64.png resources/chromeos/zip_archiver/icons/icon96.png resources/chromeos/zip_archiver/js/app.js resources/chromeos/zip_archiver/js/background.js resources/chromeos/zip_archiver/js/build-config.js resources/chromeos/zip_archiver/js/compressor.js resources/chromeos/zip_archiver/js/decompressor.js resources/chromeos/zip_archiver/js/file_operation_utils.js resources/chromeos/zip_archiver/js/main.js resources/chromeos/zip_archiver/js/passphrase-dialog.js resources/chromeos/zip_archiver/js/passphrase-manager.js resources/chromeos/zip_archiver/js/request.js resources/chromeos/zip_archiver/js/types.js resources/chromeos/zip_archiver/js/unpacker.js resources/chromeos/zip_archiver/js/volume.js sent 1,217,709,945 bytes received 244,737 bytes 62,459,214.46 bytes/sec total size is 1,305,871,151 speedup is 1.07 21:50:38: INFO: Starting UI... 21:50:38: INFO: RunCommand: ssh -p 22 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- true 21:50:38: INFO: RunCommand: ssh -p 22 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- mkdir -p /usr/local/cros_test/out_kevin/Release 21:50:39: INFO: [mode:scp] copy: out_kevin/Release/tmpbkmp3K.sh -> variable_chromeos_device_hostname:/usr/local/cros_test/out_kevin/Release 21:50:39: INFO: RunCommand: ssh -p 22 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- mkdir -p /usr/local/cros_test/out_kevin/Release 21:50:39: INFO: RunCommand: /bin/bash -c 'ssh -p 22 -oConnectionAttempts=4 -oUserKnownHostsFile=/dev/null -oProtocol=2 -oConnectTimeout=30 -oServerAliveCountMax=3 -oStrictHostKeyChecking=no -oServerAliveInterval=10 -oNumberOfPasswordPrompts=0 -oIdentitiesOnly=yes -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- "cd /usr/local/cros_test/out_kevin/Release && ./tmpbkmp3K.sh"' WARNING:root:Unable to import cv2 due to: cv2 has version $Rev: 4557 $, but version at or above 2.4.8 and below 3.0.0 is required INFO:root:RunCryptohomeTest: Starting chrome and logging in. INFO:root:Chose browser: PossibleCrOSBrowser(browser_type=system) INFO:root:(Re)starting the ui (logs the user out) DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:sh -c stop ui DEBUG:root:['sh', '-c', 'stop ui'] DEBUG:root: > stdout=[ui stop/waiting ], stderr=[] DEBUG:root:rm -rf /var/lib/whitelist/* DEBUG:root:['sh', '-c', 'rm -rf /var/lib/whitelist/*'] DEBUG:root:rm -rf /home/chronos/Local\ State DEBUG:root:['sh', '-c', 'rm -rf /home/chronos/Local\\ State'] DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'status ui'] DEBUG:root:IsServiceRunning(ui)->False DEBUG:root:sh -c start ui DEBUG:root:['sh', '-c', 'start ui'] DEBUG:root: > stdout=[ui start/running, process 4291 ], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[228 processes] DEBUG:root:sh -c cryptohome --action=remove --force --user=test@test.test DEBUG:root:['sh', '-c', 'cryptohome --action=remove --force --user=test@test.test'] DEBUG:root: > stdout=[Remove succeeded. ], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[228 processes] DEBUG:root:rm -rf /home/chronos/DevToolsActivePort DEBUG:root:['sh', '-c', 'rm -rf /home/chronos/DevToolsActivePort'] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[228 processes] INFO:root:Restarting Chrome (pid=4315) with remote port INFO:root:Starting Chrome: dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true 'array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services"' array:string: DEBUG:root:sh -c dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string: DEBUG:root:['sh', '-c', 'dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\\,*/chromeos/login/*=2\\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string:'] DEBUG:root: > stdout=[], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpHtp6X_) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp0f2FOg) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpouKGTO) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp3VMlW6) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpNOSvA6) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpNXdpxl) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpCsMkDh) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpiObCwa) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmptjgKZT) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp9luZAn) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpwKhgI0) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->39037 /devtools/browser/49ecbac7-6407-4895-83fe-d08f5782540e INFO:root:DoNothingForwarder started between 127.0.0.1:39037 and 39037 INFO:root:Created DevToolsClientBackend from ws://127.0.0.1:39037/devtools/browser/49ecbac7-6407-4895-83fe-d08f5782540e DEBUG:root:InspectorBackend._Connect() to ws://127.0.0.1:39037/devtools/page/0210D6469878CF57AD182CC5BFE3B754 DEBUG:root:sent [{ "id": 0, "method": "Log.enable" }] DEBUG:root:got [{ "id": 0, "result": {} }] DEBUG:root:sent [{ "id": 1, "method": "Page.enable" }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "source": "deprecation", "text": "HTML Imports is deprecated and will be removed in M73, around March 2019. Please use ES modules instead. See https://www.chromestatus.com/features/5144752345317376 for more details.", "timestamp": 1556056245129.415 } } }] DEBUG:root:got [{ "id": 1, "result": {} }] DEBUG:root:sent [{ "id": 2, "method": "ServiceWorker.enable" }] DEBUG:root:got [{ "id": 2, "result": {} }] INFO:root:Invoking Oobe.loginForTesting DEBUG:root:sent [{ "id": 3, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "ServiceWorker.workerRegistrationUpdated", "params": { "registrations": [] } }] DEBUG:root:got [{ "method": "ServiceWorker.workerVersionUpdated", "params": { "versions": [] } }] DEBUG:root:got [{ "id": 3, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 4, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 4, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 5, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "lineNumber": 441, "source": "deprecation", "stackTrace": { "callFrames": [ { "columnNumber": 9, "functionName": "", "lineNumber": 441, "scriptId": "38", "url": "chrome://resources/polymer/v1_0/polymer/polymer-micro-extracted.js" } ] }, "text": "document.registerElement is deprecated and will be removed in M73, around March 2019. Please use window.customElements.define instead. See https://www.chromestatus.com/features/4642138092470272 for more details.", "timestamp": 1556056245345.3049, "url": "chrome://resources/polymer/v1_0/polymer/polymer-micro-extracted.js" } } }] DEBUG:root:got [{ "id": 5, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 6, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 6, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 7, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 7, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 8, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 8, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 9, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 9, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 10, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 10, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 11, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 11, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 12, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 12, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 13, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "lineNumber": 2082, "source": "deprecation", "stackTrace": { "callFrames": [ { "columnNumber": 5, "functionName": "_createLocalRoot", "lineNumber": 2082, "scriptId": "39", "url": "chrome://resources/polymer/v1_0/polymer/polymer-mini-extracted.js" } ] }, "text": "Element.createShadowRoot is deprecated and will be removed in M73, around March 2019. Please use Element.attachShadow instead. See https://www.chromestatus.com/features/4507242028072960 for more details.", "timestamp": 1556056246290.689, "url": "chrome://resources/polymer/v1_0/polymer/polymer-mini-extracted.js" } } }] DEBUG:root:got [{ "id": 13, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 14, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "6B837ABDD340B5236D385F7CC949C481", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "6B837ABDD340B5236D385F7CC949C481" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "6B837ABDD340B5236D385F7CC949C481", "loaderId": "FFA6A9D44C9CE0D3AB26FF53C1E9BBAA", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "6B837ABDD340B5236D385F7CC949C481" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "B24E58054A74B69E3F5FDFB3B221F630", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "B24E58054A74B69E3F5FDFB3B221F630" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "B24E58054A74B69E3F5FDFB3B221F630", "loaderId": "8B99AD84BDC063AFCC847EEF41CEB86C", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "B24E58054A74B69E3F5FDFB3B221F630" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "72FB67A4B2D4B3CBCB7DF42C6D33F171", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "72FB67A4B2D4B3CBCB7DF42C6D33F171" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "72FB67A4B2D4B3CBCB7DF42C6D33F171", "loaderId": "D5F061F5C89CF76674711D42A411F59A", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "72FB67A4B2D4B3CBCB7DF42C6D33F171" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "AAEC20EF8CABE967D5D39A8C27F2AB2E", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "AAEC20EF8CABE967D5D39A8C27F2AB2E" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "AAEC20EF8CABE967D5D39A8C27F2AB2E", "loaderId": "3BCF518F7B846C5D11FC9180F26E366A", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "AAEC20EF8CABE967D5D39A8C27F2AB2E" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "689AC7018FDD1EB782AC9921C981F1CC", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "689AC7018FDD1EB782AC9921C981F1CC" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "689AC7018FDD1EB782AC9921C981F1CC", "loaderId": "946AEB9266DA02675D8173688C37A2FC", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "689AC7018FDD1EB782AC9921C981F1CC" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "18F93426347CCF044E7AD9B65D817A21", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "18F93426347CCF044E7AD9B65D817A21" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "18F93426347CCF044E7AD9B65D817A21", "loaderId": "23D73C2A8AA285854A15B962A485F42B", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "18F93426347CCF044E7AD9B65D817A21" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "7A824F65A2FD20E691942045566E2EBC", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "7A824F65A2FD20E691942045566E2EBC" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "7A824F65A2FD20E691942045566E2EBC", "loaderId": "6396462FC0EEC6E910B67C5F512EA503", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "7A824F65A2FD20E691942045566E2EBC" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "C20EAAC574A1D98728693F6F92369372", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "C20EAAC574A1D98728693F6F92369372" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "C20EAAC574A1D98728693F6F92369372", "loaderId": "97E36D5D633F4C784406A4D747BE99F7", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "C20EAAC574A1D98728693F6F92369372" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "5AB664BE52CBA378820384EC5B37BB8F", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "5AB664BE52CBA378820384EC5B37BB8F" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "5AB664BE52CBA378820384EC5B37BB8F", "loaderId": "07A9BF5D309D6E2FA46F001FC403B0F9", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "5AB664BE52CBA378820384EC5B37BB8F" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "15C5C182AB05729C8BF021C436CAD032", "parentFrameId": "0210D6469878CF57AD182CC5BFE3B754", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "15C5C182AB05729C8BF021C436CAD032" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "15C5C182AB05729C8BF021C436CAD032", "loaderId": "FB1173CC34936EDC2E68E3800E9DAE11", "mimeType": "text/html", "name": "", "parentId": "0210D6469878CF57AD182CC5BFE3B754", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "15C5C182AB05729C8BF021C436CAD032" } }] DEBUG:root:got [{ "method": "Page.domContentEventFired", "params": { "timestamp": 72.278887999999995 } }] DEBUG:root:got [{ "id": 14, "result": { "result": { "type": "boolean", "value": true } } }] DEBUG:root:sent [{ "id": 15, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe.loginForTesting == 'undefined'", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 15, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 16, "method": "Runtime.evaluate", "params": { "expression": "Oobe.loginForTesting(\"test@test.test\", \"\", \"12345\", false); 0;", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Page.loadEventFired", "params": { "timestamp": 73.210336999999996 } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "0210D6469878CF57AD182CC5BFE3B754" } }] DEBUG:root:got [{ "id": 16, "result": { "result": { "description": "0", "type": "number", "value": 0 } } }] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] INFO:root:Browser is up! DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[241 processes] DEBUG:root:sent [{ "id": 0, "method": "SystemInfo.getInfo" }] DEBUG:root:got [{ "id": 0, "result": { "commandLine": "/opt/google/chrome/chrome --use-gl=egl --edge-touch-filtering --enable-webgl-image-chromium --enable-features=Pepper3DImageChromium,PointerEvent,MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI --num-raster-threads=2 --gpu-sandbox-failures-fatal=yes --gpu-sandbox-start-early --passive-listeners-default=true --enable-logging --log-level=1 --use-cras --enable-wayland-server --user-data-dir=/home/chronos --system-developer-mode --disable-logging-redirect --login-profile=user --has-chromeos-keyboard --enable-touchview --enable-consumer-kiosk --arc-transition-migration-required --enterprise-enrollment-initial-modulus=15 --enterprise-enrollment-modulus-limit=19 --disable-demo-mode --login-manager --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --ignore-background-tasks --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --trace-startup-owner=devtools --enable-smooth-scrolling --enable-threaded-compositing --remote-debugging-port=0 --start-maximized --ash-disable-system-sounds --oobe-skip-postlogin --allow-failed-policy-fetch-for-test --disable-gaia-services --testing-channel=NamedTestingInterface:/tmp/.org.chromium.Chromium.kxVLO6/.org.chromium.Chromium.Exors3 --vmodule=*/chrome/browser/chromeos/account_manager/*=1,*/chromeos/components/account_manager/*=1,*/chromeos/power/auto_screen_brightness/*=1,*/forced_extensions/installation_tracker*=2,extension_downloader=2,*/feedback_uploader*=1,*/feedback_private/*=1,existing_user_controller=2,*/ash/wm/tablet_mode/*=1,auto_enrollment_controller=1,*/ui/ozone/*=1,*/ui/display/manager/chromeos/*=1,update_engine=1,component_updater_service=1,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2 --enable-features=Pepper3DImageChromium,PointerEvent,MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI --enable-surface-synchronization --ui-compositor-memory-limit-when-visible-mb=144", "gpu": { "auxAttributes": { "amdSwitchable": false, "canSupportThreadedTextureMailbox": false, "directRenderingVersion": "", "encrypted_only": false, "glExtensions": "GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_EXT_multisampled_render_to_texture2 GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_sRGB_R8 GL_EXT_texture_sRGB_RG8 GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_shader_non_constant_global_initializers GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex GL_EXT_buffer_storage ", "glRenderer": "Mali-T860", "glResetNotificationStrategy": 33362, "glVendor": "ARM", "glVersion": "OpenGL ES 3.2 v1.r26p0-01rel0.8597fc75a24d2d76acfad4df6d4fe6aa", "glWsExtensions": "EGL_KHR_partial_update EGL_EXT_swap_buffers_with_damage EGL_KHR_swap_buffers_with_damage EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_image_pixmap EGL_ANDROID_native_fence_sync EGL_EXT_image_flush_external EGL_KHR_config_attribs EGL_KHR_image EGL_KHR_image_base EGL_KHR_fence_sync EGL_KHR_wait_sync EGL_KHR_gl_colorspace EGL_KHR_get_all_proc_addresses EGL_IMG_context_priority EGL_KHR_no_config_context EGL_EXT_pixel_format_float EGL_ARM_pixmap_multisample_discard EGL_ARM_implicit_external_sync EGL_KHR_gl_texture_2D_image EGL_KHR_gl_renderbuffer_image EGL_KHR_create_context EGL_KHR_surfaceless_context EGL_KHR_gl_texture_cubemap_image EGL_EXT_image_gl_colorspace EGL_EXT_create_context_robustness", "glWsVendor": "ARM", "glWsVersion": "1.4 Midgard-\"r26p0-01rel0\"", "inProcessGpu": false, "initializationTime": 0.027941000000000001, "jpegDecodeAcceleratorSupported": false, "maxFramerateDenominator": 1, "maxFramerateNumerator": 30, "maxMsaaSamples": "16", "maxResolutionHeight": 1088, "maxResolutionWidth": 1920, "minResolutionHeight": 48, "minResolutionWidth": 48, "oopRasterizationSupported": true, "optimus": false, "passthroughCmdDecoder": false, "pixelShaderVersion": "3.20", "processCrashCount": 0, "profile": 1, "sandboxed": true, "softwareRendering": false, "vertexShaderVersion": "3.20", "videoDecodeAcceleratorFlags": 0 }, "devices": [ { "deviceId": 0, "deviceString": "Mali-T860", "vendorId": 0, "vendorString": "ARM" } ], "driverBugWorkarounds": [ "clear_uniforms_before_first_program_use", "disable_discard_framebuffer", "disable_non_empty_post_sub_buffers_for_onscreen_surfaces", "disable_program_caching_for_transform_feedback", "scalarize_vec_and_mat_constructor_args", "use_virtualized_gl_contexts", "disabled_extension_GL_KHR_blend_equation_advanced", "disabled_extension_GL_KHR_blend_equation_advanced_coherent" ], "featureStatus": { "2d_canvas": "enabled", "flash_3d": "enabled", "flash_stage3d": "enabled", "flash_stage3d_baseline": "enabled", "gpu_compositing": "enabled", "multiple_raster_threads": "enabled_force_on", "oop_rasterization": "unavailable_off", "protected_video_decode": "unavailable_off", "rasterization": "unavailable_off", "skia_renderer": "disabled_off", "surface_control": "disabled_off", "surface_synchronization": "enabled_on", "video_decode": "enabled", "viz_display_compositor": "disabled_off", "viz_hit_test_surface_layer": "enabled_on", "webgl": "enabled", "webgl2": "enabled" } }, "modelName": "", "modelVersion": "" } }] INFO:root:Browser information: Browser started (pid=4353). OS: chromeos Browser command line: /opt/google/chrome/chrome --use-gl=egl --edge-touch-filtering --enable-webgl-image-chromium --enable-features=Pepper3DImageChromium,PointerEvent,MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI --num-raster-threads=2 --gpu-sandbox-failures-fatal=yes --gpu-sandbox-start-early --passive-listeners-default=true --enable-logging --log-level=1 --use-cras --enable-wayland-server --user-data-dir=/home/chronos --system-developer-mode --disable-logging-redirect --login-profile=user --has-chromeos-keyboard --enable-touchview --enable-consumer-kiosk --arc-transition-migration-required --enterprise-enrollment-initial-modulus=15 --enterprise-enrollment-modulus-limit=19 --disable-demo-mode --login-manager --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --ignore-background-tasks --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --trace-startup-owner=devtools --enable-smooth-scrolling --enable-threaded-compositing --remote-debugging-port=0 --start-maximized --ash-disable-system-sounds --oobe-skip-postlogin --allow-failed-policy-fetch-for-test --disable-gaia-services --testing-channel=NamedTestingInterface:/tmp/.org.chromium.Chromium.kxVLO6/.org.chromium.Chromium.Exors3 --vmodule=*/chrome/browser/chromeos/account_manager/*=1,*/chromeos/components/account_manager/*=1,*/chromeos/power/auto_screen_brightness/*=1,*/forced_extensions/installation_tracker*=2,extension_downloader=2,*/feedback_uploader*=1,*/feedback_private/*=1,existing_user_controller=2,*/ash/wm/tablet_mode/*=1,auto_enrollment_controller=1,*/ui/ozone/*=1,*/ui/display/manager/chromeos/*=1,update_engine=1,component_updater_service=1,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2 --enable-features=Pepper3DImageChromium,PointerEvent,MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI --enable-surface-synchronization --ui-compositor-memory-limit-when-visible-mb=144 GPU device 0: VENDOR = 0x0 (ARM), DEVICE = 0x0 (Mali-T860) GPU Attributes: amd_switchable : False can_support_threaded_texture_mailbox: False direct_rendering_version: encrypted_only : False gl_extensions : GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_EXT_multisampled_render_to_texture2 GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_sRGB_R8 GL_EXT_texture_sRGB_RG8 GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_shader_non_constant_global_initializers GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex GL_EXT_buffer_storage gl_renderer : Mali-T860 gl_reset_notification_strategy: 33362 gl_vendor : ARM gl_version : OpenGL ES 3.2 v1.r26p0-01rel0.8597fc75a24d2d76acfad4df6d4fe6aa gl_ws_extensions : EGL_KHR_partial_update EGL_EXT_swap_buffers_with_damage EGL_KHR_swap_buffers_with_damage EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_image_pixmap EGL_ANDROID_native_fence_sync EGL_EXT_image_flush_external EGL_KHR_config_attribs EGL_KHR_image EGL_KHR_image_base EGL_KHR_fence_sync EGL_KHR_wait_sync EGL_KHR_gl_colorspace EGL_KHR_get_all_proc_addresses EGL_IMG_context_priority EGL_KHR_no_config_context EGL_EXT_pixel_format_float EGL_ARM_pixmap_multisample_discard EGL_ARM_implicit_external_sync EGL_KHR_gl_texture_2D_image EGL_KHR_gl_renderbuffer_image EGL_KHR_create_context EGL_KHR_surfaceless_context EGL_KHR_gl_texture_cubemap_image EGL_EXT_image_gl_colorspace EGL_EXT_create_context_robustness gl_ws_vendor : ARM gl_ws_version : 1.4 Midgard-"r26p0-01rel0" in_process_gpu : False initialization_time : 0.027941 jpeg_decode_accelerator_supported: False max_framerate_denominator: 1 max_framerate_numerator: 30 max_msaa_samples : 16 max_resolution_height: 1088 max_resolution_width: 1920 min_resolution_height: 48 min_resolution_width: 48 oop_rasterization_supported: True optimus : False passthrough_cmd_decoder: False pixel_shader_version: 3.20 process_crash_count : 0 profile : 1 sandboxed : True software_rendering : False vertex_shader_version: 3.20 video_decode_accelerator_flags: 0 Feature Status: 2d_canvas : enabled flash_3d : enabled flash_stage3d : enabled flash_stage3d_baseline: enabled gpu_compositing : enabled multiple_raster_threads: enabled_force_on oop_rasterization : unavailable_off protected_video_decode: unavailable_off rasterization : unavailable_off skia_renderer : disabled_off surface_control : disabled_off surface_synchronization: enabled_on video_decode : enabled viz_display_compositor: disabled_off viz_hit_test_surface_layer: enabled_on webgl : enabled webgl2 : enabled Driver Bug Workarounds: clear_uniforms_before_first_program_use disable_discard_framebuffer disable_non_empty_post_sub_buffers_for_onscreen_surfaces disable_program_caching_for_transform_feedback scalarize_vec_and_mat_constructor_args use_virtualized_gl_contexts disabled_extension__gl__khr_blend_equation_advanced disabled_extension__gl__khr_blend_equation_advanced_coherent DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[244 processes] INFO:root:Checking mounted cryptohome. DEBUG:root:Running 'cryptohome-path user 'test@test.test'' DEBUG:root:"cryptohome-path user 'test@test.test'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/user ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/u-ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/u-ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/user/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /run/daemon-store/usb_bouncer/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 DEBUG:root:Running 'grep /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Running 'cryptohome-path system 'test@test.test'' DEBUG:root:"cryptohome-path system 'test@test.test'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/user ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/u-ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/u-ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /home/chronos/user/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /run/daemon-store/usb_bouncer/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 DEBUG:root:Running 'grep /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Running 'e4crypt get_policy /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 | cut -d ' ' -f 2 2>&1' DEBUG:root:"e4crypt get_policy /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 | cut -d ' ' -f 2 2>&1" DEBUG:root:[stdout] 3064712f3474b313 DEBUG:root:Running 'keyctl show @s | grep 3064712f3474b313 | wc -l 2>&1' DEBUG:root:'keyctl show @s | grep 3064712f3474b313 | wc -l 2>&1' DEBUG:root:[stdout] 1 DEBUG:root:Running 'e4crypt get_policy /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 | cut -d ' ' -f 2 2>&1' DEBUG:root:"e4crypt get_policy /home/root/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 | cut -d ' ' -f 2 2>&1" DEBUG:root:[stdout] 3064712f3474b313 DEBUG:root:Running 'keyctl show @s | grep 3064712f3474b313 | wc -l 2>&1' DEBUG:root:'keyctl show @s | grep 3064712f3474b313 | wc -l 2>&1' DEBUG:root:[stdout] 1 DEBUG:root:InspectorBackend._Connect() to ws://127.0.0.1:39037/devtools/page/25C80AEAEADFB5A1CEEB7796D16F6FDF DEBUG:root:sent [{ "id": 0, "method": "Log.enable" }] DEBUG:root:got [{ "id": 0, "result": {} }] DEBUG:root:sent [{ "id": 1, "method": "Page.enable" }] DEBUG:root:got [{ "id": 1, "result": {} }] DEBUG:root:sent [{ "id": 2, "method": "ServiceWorker.enable" }] DEBUG:root:got [{ "id": 2, "result": {} }] DEBUG:root:sent [{ "id": 3, "method": "Page.addScriptToEvaluateOnLoad", "params": { "scriptSource": "// Copyright 2014 The Chromium Authors. All rights reserved.\n// Use of this source code is governed by a BSD-style license that can be\n// found in the LICENSE file.\n\n'use strict';\n\n/**\n * @fileoverview This file provides a JavaScript helper function that\n * determines when network quiescence has been reached based on the time since\n * the last resource was received.\n */\n(function() {\n\n // Make executing this code idempotent.\n if (window.__telemetry_testHasReachedNetworkQuiescence) {\n return;\n }\n\n // Some benchmarks patch window.performance to make it deterministic.\n // Save the original performance object before it is patched.\n var real_performance = window.performance;\n\n // Set the Resource Timing interface functions that will be used below\n // to use whatever version is available currently regardless of vendor\n // prefix.\n real_performance.clearResourceTimings =\n (real_performance.clearResourceTimings ||\n real_performance.mozClearResourceTimings ||\n real_performance.msClearResourceTimings ||\n real_performance.oClearResourceTimings ||\n real_performance.webkitClearResourceTimings);\n\n real_performance.getEntriesByType =\n (real_performance.getEntriesByType ||\n real_performance.mozGetEntriesByType ||\n real_performance.msGetEntriesByType ||\n real_performance.oGetEntriesByType ||\n real_performance.webkitGetEntriesByType);\n\n // This variable will available to the function below and it will be\n // persistent across different function calls. It stores the last\n // entry in the list of PerformanceResourceTiming objects returned by\n // real_performance.getEntriesByType('resource').\n //\n // The reason for doing it this way is because the buffer for\n // PerformanceResourceTiming objects has a limit, and once it's full,\n // new entries are not added. We're only interested in the last entry,\n // so we can clear new entries when they're added.\n var lastEntry = null;\n\n // True when no resource has been loaded from the network for\n //|QUIESCENCE_TIMEOUT_MS| milliseconds. This value is sticky.\n var hasReachedQuiesence = false;\n\n // Time to wait before declaring network quiescence in milliseconds.\n var QUIESCENCE_TIMEOUT_MS = 2000;\n\n /**\n * This method uses the Resource Timing interface, which is described at\n * http://www.w3.org/TR/resource-timing/. It determines whether the time\n * since lodading any resources such as images and script files (including\n * resources requested via XMLHttpRequest) has exceeded a threshold defined\n # by |QUIESCENCE_TIMEOUT_MS|.\n *\n * @return {boolean} True if the time since either the load event, or the last\n * resource was received after the load event exceeds the aforementioned\n * threshold. This state is sticky, so once this function returns true for a\n * given page, it will always return true.\n */\n window.__telemetry_testHasReachedNetworkQuiescence = function() {\n if (hasReachedQuiesence) {\n return true;\n }\n\n if (window.document.readyState !== 'complete') {\n return false;\n }\n\n var resourceTimings = real_performance.getEntriesByType('resource');\n if (resourceTimings.length > 0) {\n lastEntry = resourceTimings.pop();\n real_performance.clearResourceTimings();\n }\n\n // The times for performance.now() and in the PerformanceResourceTiming\n // objects are all in milliseconds since performance.timing.navigationStart,\n // so we must also get load time in the same terms.\n var timing = real_performance.timing;\n var loadTime = timing.loadEventEnd - timing.navigationStart;\n var lastResponseTimeMs = 0;\n\n // If there have been no resource timing entries, or the last entry was\n // before the load event, then use the time since the load event.\n if (!lastEntry || lastEntry.responseEnd < loadTime) {\n lastResponseTimeMs = real_performance.now() - loadTime;\n } else {\n lastResponseTimeMs = real_performance.now() - lastEntry.responseEnd;\n }\n\n if (lastResponseTimeMs >= QUIESCENCE_TIMEOUT_MS) {\n hasReachedQuiesence = true;\n }\n\n return hasReachedQuiesence;\n }\n\n})();\n// Copyright 2017 The Chromium Authors. All rights reserved.\n// Use of this source code is governed by a BSD-style license that can be\n// found in the LICENSE file.\n\n'use strict';\n\n/**\n * @fileoverview This file provides a JavaScript helper function that\n * determines whether service worker registration has completed.\n * TODO(crbug.com/768701): Move the ServiceWorker state operations to\n * InspectorServiceWorker by implementing _OnNotification().\n */\n(function() {\n // Make executing this code idempotent.\n if (window.__telemetry_getServiceWorkerState) {\n return;\n }\n\n // These variables are used for checking service worker state.\n let isServiceWorkerAccessable = true;\n let isServiceWorkerRegistered = false;\n let isServiceWorkerActivated = false;\n\n window.__telemetry_getServiceWorkerState = () => {\n // These returned string should exactly match strings used in\n // ServiceWorkerState, in web_contents.py.\n if (isServiceWorkerActivated) { return 'activated'; }\n if (isServiceWorkerRegistered) { return 'installing'; }\n return 'not registered';\n };\n\n // Check if service worker is accessible.\n try {\n if (!navigator.serviceWorker) {\n isServiceWorkerAccessable = false;\n }\n } catch (e) {\n // Ignore the exception here. We will frequently meet it because\n // navigator.serviceWorker is not accessible when loading about:blank etc.\n isServiceWorkerAccessable = false;\n }\n\n if (!isServiceWorkerAccessable) { return; }\n\n // Patch navigator.serviceWorker.register().\n navigator.serviceWorker.originalRegister =\n navigator.serviceWorker.register;\n navigator.serviceWorker.register = (name, options = {}) => {\n isServiceWorkerRegistered = true;\n return navigator.serviceWorker.originalRegister(name, options).then(\n (registration) => {\n let serviceworker = null;\n // Service worker always have .active or .waiting or .installing.\n if (registration.active) {\n if (registration.active.state === 'activated') {\n isServiceWorkerActivated = true;\n return registration;\n }\n serviceworker = registration.active;\n } else if (registration.waiting) {\n serviceworker = registration.waiting;\n } else {\n serviceworker = registration.installing;\n }\n serviceworker.addEventListener('statechange', (event) => {\n if (serviceworker.state === 'activated') {\n isServiceWorkerActivated = true;\n } else if (serviceworker.state === 'redundant') {\n isServiceWorkerRegistered = false;\n }\n });\n return registration;\n },\n (error) => {\n isServiceWorkerRegistered = false;\n return Promise.reject(error);\n });\n };\n})();\n" } }] DEBUG:root:got [{ "method": "ServiceWorker.workerRegistrationUpdated", "params": { "registrations": [] } }] DEBUG:root:got [{ "method": "ServiceWorker.workerVersionUpdated", "params": { "versions": [] } }] DEBUG:root:got [{ "id": 3, "result": { "identifier": "1" } }] DEBUG:root:sent [{ "id": 4, "method": "Page.navigate", "params": { "url": "about:blank" } }] DEBUG:root:got [{ "id": 4, "result": { "frameId": "25C80AEAEADFB5A1CEEB7796D16F6FDF", "loaderId": "37A7A1A56AAEFEBC6A44CE7F605173A8" } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "25C80AEAEADFB5A1CEEB7796D16F6FDF" } }] DEBUG:root:got [{ "method": "Page.frameDetached", "params": { "frameId": "C1A2FBDBB87374897C56639AC7C9F866" } }] DEBUG:root:got [{ "method": "Page.frameDetached", "params": { "frameId": "5885115895F46F76181890965BE34924" } }] DEBUG:root:got [{ "method": "Page.frameDetached", "params": { "frameId": "9FAB054089F5622DCF9C957D134DA197" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "25C80AEAEADFB5A1CEEB7796D16F6FDF", "loaderId": "37A7A1A56AAEFEBC6A44CE7F605173A8", "mimeType": "text/html", "securityOrigin": "://", "url": "about:blank" } } }] INFO:root:Evaluating JavaScript. DEBUG:root:sent [{ "id": 5, "method": "Runtime.evaluate", "params": { "expression": "2+2", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Page.loadEventFired", "params": { "timestamp": 77.866730000000004 } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "25C80AEAEADFB5A1CEEB7796D16F6FDF" } }] DEBUG:root:got [{ "method": "Page.domContentEventFired", "params": { "timestamp": 77.867907000000002 } }] DEBUG:root:got [{ "id": 5, "result": { "result": { "description": "4", "type": "number", "value": 4 } } }] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[244 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[244 processes] INFO:root:Closing browser (pid=4353) ... INFO:root:(Re)starting the ui (logs the user out) DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'status ui'] DEBUG:root:IsServiceRunning(ui)->True DEBUG:root:sh -c restart ui DEBUG:root:['sh', '-c', 'restart ui'] DEBUG:root: > stdout=[ui start/running, process 5224 ], stderr=[] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57: No such file or directory ] DEBUG:root:sh -c cryptohome-path user 'test@test.test' DEBUG:root:['sh', '-c', "cryptohome-path user 'test@test.test'"] DEBUG:root: > stdout=[/home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/ff0fbcc642fbad36668dc770dc5b9f5fc5e01d57'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] INFO:root:Browser is closed. INFO:root:RunIncognitoTest INFO:root:Chose browser: PossibleCrOSBrowser(browser_type=system-guest) INFO:root:(Re)starting the ui (logs the user out) DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:sh -c stop ui DEBUG:root:['sh', '-c', 'stop ui'] DEBUG:root: > stdout=[ui stop/waiting ], stderr=[] DEBUG:root:rm -rf /var/lib/whitelist/* DEBUG:root:['sh', '-c', 'rm -rf /var/lib/whitelist/*'] DEBUG:root:rm -rf /home/chronos/Local\ State DEBUG:root:['sh', '-c', 'rm -rf /home/chronos/Local\\ State'] DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'status ui'] DEBUG:root:IsServiceRunning(ui)->False DEBUG:root:sh -c start ui DEBUG:root:['sh', '-c', 'start ui'] DEBUG:root: > stdout=[ui start/running, process 5476 ], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[228 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] DEBUG:root:sh -c cryptohome --action=remove --force --user=test@test.test DEBUG:root:['sh', '-c', 'cryptohome --action=remove --force --user=test@test.test'] DEBUG:root: > stdout=[Remove succeeded. ], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] DEBUG:root:rm -rf /home/chronos/DevToolsActivePort DEBUG:root:['sh', '-c', 'rm -rf /home/chronos/DevToolsActivePort'] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] INFO:root:Restarting Chrome (pid=5496) with remote port INFO:root:Starting Chrome: dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true 'array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services"' array:string: DEBUG:root:sh -c dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string: DEBUG:root:['sh', '-c', 'dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--trace-startup-owner=devtools,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--oobe-skip-postlogin,--vmodule=*/chromeos/net/*=2\\,*/chromeos/login/*=2\\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string:'] DEBUG:root: > stdout=[], stderr=[] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[229 processes] DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpAtwmwu) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpbfL1uI) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpyU0eyU) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpVK2eaj) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpYfczVP) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpelOA4k) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpV5uU4c) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpjpIjWN) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpqMRxGh) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpOWA3_S) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpT1H2Ph) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpMY4CVs) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpL17aKr) DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp8_QJ9X) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:Created DevToolsClientBackend from ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[239 processes] DEBUG:root:InspectorBackend._Connect() to ws://127.0.0.1:38806/devtools/page/2479B9DB3CECCE7FBC824E623FED493E DEBUG:root:sent [{ "id": 0, "method": "Log.enable" }] DEBUG:root:got [{ "id": 0, "result": {} }] DEBUG:root:sent [{ "id": 1, "method": "Page.enable" }] DEBUG:root:got [{ "id": 1, "result": {} }] DEBUG:root:sent [{ "id": 2, "method": "ServiceWorker.enable" }] DEBUG:root:got [{ "id": 2, "result": {} }] INFO:root:Invoking Oobe.guestLoginForTesting DEBUG:root:sent [{ "id": 3, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "ServiceWorker.workerRegistrationUpdated", "params": { "registrations": [] } }] DEBUG:root:got [{ "method": "ServiceWorker.workerVersionUpdated", "params": { "versions": [] } }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "source": "deprecation", "text": "HTML Imports is deprecated and will be removed in M73, around March 2019. Please use ES modules instead. See https://www.chromestatus.com/features/5144752345317376 for more details.", "timestamp": 1556056259002.042 } } }] DEBUG:root:got [{ "id": 3, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 4, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 4, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 5, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 5, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 6, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "lineNumber": 441, "source": "deprecation", "stackTrace": { "callFrames": [ { "columnNumber": 9, "functionName": "", "lineNumber": 441, "scriptId": "38", "url": "chrome://resources/polymer/v1_0/polymer/polymer-micro-extracted.js" } ] }, "text": "document.registerElement is deprecated and will be removed in M73, around March 2019. Please use window.customElements.define instead. See https://www.chromestatus.com/features/4642138092470272 for more details.", "timestamp": 1556056259238.3789, "url": "chrome://resources/polymer/v1_0/polymer/polymer-micro-extracted.js" } } }] DEBUG:root:got [{ "id": 6, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 7, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 7, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 8, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 8, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 9, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 9, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 10, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 10, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 11, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 11, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 12, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Log.entryAdded", "params": { "entry": { "level": "warning", "lineNumber": 2082, "source": "deprecation", "stackTrace": { "callFrames": [ { "columnNumber": 5, "functionName": "_createLocalRoot", "lineNumber": 2082, "scriptId": "39", "url": "chrome://resources/polymer/v1_0/polymer/polymer-mini-extracted.js" } ] }, "text": "Element.createShadowRoot is deprecated and will be removed in M73, around March 2019. Please use Element.attachShadow instead. See https://www.chromestatus.com/features/4507242028072960 for more details.", "timestamp": 1556056260154.3401, "url": "chrome://resources/polymer/v1_0/polymer/polymer-mini-extracted.js" } } }] DEBUG:root:got [{ "id": 12, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 13, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe == 'function' && Oobe.readyForTesting", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "888D4EA01BFE35FE95A77C439DF3EB88", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "888D4EA01BFE35FE95A77C439DF3EB88" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "888D4EA01BFE35FE95A77C439DF3EB88", "loaderId": "FC4ABA77019A1231D417E438DB2B4CBF", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "888D4EA01BFE35FE95A77C439DF3EB88" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "3BDC29901DEC3E3F43B4ACF18ACEC254", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "3BDC29901DEC3E3F43B4ACF18ACEC254" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "3BDC29901DEC3E3F43B4ACF18ACEC254", "loaderId": "8195A5B89C36315BCC5A783165286E06", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "3BDC29901DEC3E3F43B4ACF18ACEC254" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "6CA74C7624B886CB1B3105DF8C7BCC97", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "6CA74C7624B886CB1B3105DF8C7BCC97" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "6CA74C7624B886CB1B3105DF8C7BCC97", "loaderId": "025F51900D76951227ED88D7569F36F4", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "6CA74C7624B886CB1B3105DF8C7BCC97" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "39C920C2DFAFD3A4895484460F1F5195", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "39C920C2DFAFD3A4895484460F1F5195" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "39C920C2DFAFD3A4895484460F1F5195", "loaderId": "84F61D7A8E9E9AC2D221D4EA831C9F05", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "39C920C2DFAFD3A4895484460F1F5195" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "7CDE6C93F2157172708827A3136F7D2E", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "7CDE6C93F2157172708827A3136F7D2E" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "7CDE6C93F2157172708827A3136F7D2E", "loaderId": "35BD09EEA3E6E22E72BF656B4E4089EA", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "7CDE6C93F2157172708827A3136F7D2E" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "879E66A83102112478104FC2410CF1E2", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "879E66A83102112478104FC2410CF1E2" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "879E66A83102112478104FC2410CF1E2", "loaderId": "DA5A9B6DADA703B8585FA650107BB455", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "879E66A83102112478104FC2410CF1E2" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "5515661A59978C6494BC077E1CA7A4B4", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "5515661A59978C6494BC077E1CA7A4B4" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "5515661A59978C6494BC077E1CA7A4B4", "loaderId": "29EAABA35CE131D094F7E349705B848B", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "5515661A59978C6494BC077E1CA7A4B4" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "4096DBA1487F2C7721A0C83810D7B281", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "4096DBA1487F2C7721A0C83810D7B281" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "4096DBA1487F2C7721A0C83810D7B281", "loaderId": "AE464F649D441F904A1F13B843AF35CC", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "4096DBA1487F2C7721A0C83810D7B281" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "6498557391440E1188975D6302185FF8", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "6498557391440E1188975D6302185FF8" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "6498557391440E1188975D6302185FF8", "loaderId": "3F361CEE99BA2DA50AFBB95410FD7A99", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "6498557391440E1188975D6302185FF8" } }] DEBUG:root:got [{ "method": "Page.frameAttached", "params": { "frameId": "14A37E7E5537774705687DBA7BF8821D", "parentFrameId": "2479B9DB3CECCE7FBC824E623FED493E", "stack": { "callFrames": [ { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 8, "functionName": "GuestViewContainer", "lineNumber": 35, "scriptId": "20", "url": "extensions::guestViewContainer" }, { "columnNumber": 12, "functionName": "WebViewImpl", "lineNumber": 19, "scriptId": "25", "url": "extensions::webView" }, { "columnNumber": 4, "functionName": "ChromeWebViewImpl", "lineNumber": 141, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 30, "functionName": "ChromeWebViewElement", "lineNumber": 215, "scriptId": "14", "url": "extensions::chromeWebView" }, { "columnNumber": 21, "functionName": "", "lineNumber": 19, "scriptId": "18", "url": "extensions::safeMethods" }, { "columnNumber": 27, "functionName": "", "lineNumber": 129, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 27, "functionName": "registerGuestViewElement", "lineNumber": 118, "scriptId": "19", "url": "extensions::guestViewContainerElement" }, { "columnNumber": 4, "functionName": "listener", "lineNumber": 27, "scriptId": "19", "url": "extensions::guestViewContainerElement" } ] } } }] DEBUG:root:got [{ "method": "Page.frameStartedLoading", "params": { "frameId": "14A37E7E5537774705687DBA7BF8821D" } }] DEBUG:root:got [{ "method": "Page.frameNavigated", "params": { "frame": { "id": "14A37E7E5537774705687DBA7BF8821D", "loaderId": "3567D3AD83EADD7E40A1662C60570349", "mimeType": "text/html", "name": "", "parentId": "2479B9DB3CECCE7FBC824E623FED493E", "securityOrigin": "://", "url": "about:blank" } } }] DEBUG:root:got [{ "method": "Page.frameStoppedLoading", "params": { "frameId": "14A37E7E5537774705687DBA7BF8821D" } }] DEBUG:root:got [{ "method": "Page.domContentEventFired", "params": { "timestamp": 86.356487000000001 } }] DEBUG:root:got [{ "id": 13, "result": { "result": { "type": "boolean", "value": true } } }] DEBUG:root:sent [{ "id": 14, "method": "Runtime.evaluate", "params": { "expression": "typeof Oobe.guestLoginForTesting == 'undefined'", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 14, "result": { "result": { "type": "boolean", "value": false } } }] DEBUG:root:sent [{ "id": 15, "method": "Runtime.evaluate", "params": { "expression": "Oobe.guestLoginForTesting(); 0;", "returnByValue": true, "userGesture": false } }] DEBUG:root:got [{ "id": 15, "result": { "result": { "description": "0", "type": "number", "value": 0 } } }] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[240 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[242 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[244 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[245 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[242 processes] DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpMjKLpX) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpmGTyM6) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpF0CeFl) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmplWe5lk) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpxdKsKz) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpfYwMkP) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpYLB4Hq) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmp50boKK) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmppaLgK9) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpR2Nk9h) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpcU8RrZ) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpeRTbBG) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->38806 /devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 INFO:root:DoNothingForwarder started between 127.0.0.1:38806 and 38806 INFO:root:DevTools agent at ws://127.0.0.1:38806/devtools/browser/a5eb4db1-73bb-4df8-a0f8-a488a129bfc2 not ready yet: [Errno 111] Connection refused DEBUG:root:GetFile(/home/chronos/DevToolsActivePort, /tmp/tmpc1xExT) DEBUG:root:GetFileContents(/home/chronos/DevToolsActivePort)->33564 /devtools/browser/0a2316f6-7eed-46f3-8859-6de473d08c85 INFO:root:DoNothingForwarder started between 127.0.0.1:33564 and 33564 INFO:root:Created DevToolsClientBackend from ws://127.0.0.1:33564/devtools/browser/0a2316f6-7eed-46f3-8859-6de473d08c85 DEBUG:root:sh -c cryptohome-path user '$guest' DEBUG:root:['sh', '-c', "cryptohome-path user '$guest'"] DEBUG:root: > stdout=[/home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/loop1 /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4 ], stderr=[] INFO:root:Browser is up! DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[245 processes] DEBUG:root:sent [{ "id": 0, "method": "SystemInfo.getInfo" }] DEBUG:root:got [{ "id": 0, "result": { "commandLine": "/opt/google/chrome/chrome --gpu-sandbox-failures-fatal=yes --enable-logging --edge-touch-filtering --gpu-sandbox-start-early --num-raster-threads=2 --remote-debugging-port=0 --use-cras --use-gl=egl --user-data-dir=/home/chronos --enable-webgl-image-chromium --enable-touchview --enable-wayland-server --enable-gpu-benchmarking --has-chromeos-keyboard --login-profile=user --system-developer-mode --bwsi --homepage=chrome://newtab/ --incognito --log-level=1 --login-user=$guest --login-user=$guest --login-profile=14401d187d9f3a48a62416d2a9132343a576a7d4 --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --ignore-background-tasks --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --trace-startup-owner=devtools --enable-smooth-scrolling --enable-threaded-compositing --remote-debugging-port=0 --start-maximized --ash-disable-system-sounds --oobe-skip-postlogin --allow-failed-policy-fetch-for-test --disable-gaia-services --testing-channel=NamedTestingInterface:/tmp/.org.chromium.Chromium.xF3cao/.org.chromium.Chromium.6uEyaC --vmodule=*/chrome/browser/chromeos/account_manager/*=1,*/chromeos/components/account_manager/*=1,*/chromeos/power/auto_screen_brightness/*=1,*/forced_extensions/installation_tracker*=2,extension_downloader=2,*/feedback_uploader*=1,*/feedback_private/*=1,existing_user_controller=2,*/ash/wm/tablet_mode/*=1,auto_enrollment_controller=1,*/ui/ozone/*=1,*/ui/display/manager/chromeos/*=1,update_engine=1,component_updater_service=1,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2 --disable-sync --disable-extensions --enable-surface-synchronization --ui-compositor-memory-limit-when-visible-mb=144", "gpu": { "auxAttributes": { "amdSwitchable": false, "canSupportThreadedTextureMailbox": false, "directRenderingVersion": "", "encrypted_only": false, "glExtensions": "GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_EXT_multisampled_render_to_texture2 GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_sRGB_R8 GL_EXT_texture_sRGB_RG8 GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_shader_non_constant_global_initializers GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex GL_EXT_buffer_storage ", "glRenderer": "Mali-T860", "glResetNotificationStrategy": 33362, "glVendor": "ARM", "glVersion": "OpenGL ES 3.2 v1.r26p0-01rel0.8597fc75a24d2d76acfad4df6d4fe6aa", "glWsExtensions": "EGL_KHR_partial_update EGL_EXT_swap_buffers_with_damage EGL_KHR_swap_buffers_with_damage EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_image_pixmap EGL_ANDROID_native_fence_sync EGL_EXT_image_flush_external EGL_KHR_config_attribs EGL_KHR_image EGL_KHR_image_base EGL_KHR_fence_sync EGL_KHR_wait_sync EGL_KHR_gl_colorspace EGL_KHR_get_all_proc_addresses EGL_IMG_context_priority EGL_KHR_no_config_context EGL_EXT_pixel_format_float EGL_ARM_pixmap_multisample_discard EGL_ARM_implicit_external_sync EGL_KHR_gl_texture_2D_image EGL_KHR_gl_renderbuffer_image EGL_KHR_create_context EGL_KHR_surfaceless_context EGL_KHR_gl_texture_cubemap_image EGL_EXT_image_gl_colorspace EGL_EXT_create_context_robustness", "glWsVendor": "ARM", "glWsVersion": "1.4 Midgard-\"r26p0-01rel0\"", "inProcessGpu": false, "initializationTime": 0.039993000000000001, "jpegDecodeAcceleratorSupported": false, "maxFramerateDenominator": 1, "maxFramerateNumerator": 30, "maxMsaaSamples": "16", "maxResolutionHeight": 1088, "maxResolutionWidth": 1920, "minResolutionHeight": 48, "minResolutionWidth": 48, "oopRasterizationSupported": true, "optimus": false, "passthroughCmdDecoder": false, "pixelShaderVersion": "3.20", "processCrashCount": 0, "profile": 1, "sandboxed": true, "softwareRendering": false, "vertexShaderVersion": "3.20", "videoDecodeAcceleratorFlags": 0 }, "devices": [ { "deviceId": 0, "deviceString": "Mali-T860", "vendorId": 0, "vendorString": "ARM" } ], "driverBugWorkarounds": [ "clear_uniforms_before_first_program_use", "disable_discard_framebuffer", "disable_non_empty_post_sub_buffers_for_onscreen_surfaces", "disable_program_caching_for_transform_feedback", "scalarize_vec_and_mat_constructor_args", "use_virtualized_gl_contexts", "disabled_extension_GL_KHR_blend_equation_advanced", "disabled_extension_GL_KHR_blend_equation_advanced_coherent" ], "featureStatus": { "2d_canvas": "enabled", "flash_3d": "enabled", "flash_stage3d": "enabled", "flash_stage3d_baseline": "enabled", "gpu_compositing": "enabled", "multiple_raster_threads": "enabled_force_on", "oop_rasterization": "unavailable_off", "protected_video_decode": "unavailable_off", "rasterization": "unavailable_off", "skia_renderer": "disabled_off", "surface_control": "disabled_off", "surface_synchronization": "enabled_on", "video_decode": "enabled", "viz_display_compositor": "disabled_off", "viz_hit_test_surface_layer": "enabled_on", "webgl": "enabled", "webgl2": "enabled" } }, "modelName": "", "modelVersion": "" } }] INFO:root:Browser information: Browser started (pid=5827). OS: chromeos Browser command line: /opt/google/chrome/chrome --gpu-sandbox-failures-fatal=yes --enable-logging --edge-touch-filtering --gpu-sandbox-start-early --num-raster-threads=2 --remote-debugging-port=0 --use-cras --use-gl=egl --user-data-dir=/home/chronos --enable-webgl-image-chromium --enable-touchview --enable-wayland-server --enable-gpu-benchmarking --has-chromeos-keyboard --login-profile=user --system-developer-mode --bwsi --homepage=chrome://newtab/ --incognito --log-level=1 --login-user=$guest --login-user=$guest --login-profile=14401d187d9f3a48a62416d2a9132343a576a7d4 --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --ignore-background-tasks --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --trace-startup-owner=devtools --enable-smooth-scrolling --enable-threaded-compositing --remote-debugging-port=0 --start-maximized --ash-disable-system-sounds --oobe-skip-postlogin --allow-failed-policy-fetch-for-test --disable-gaia-services --testing-channel=NamedTestingInterface:/tmp/.org.chromium.Chromium.xF3cao/.org.chromium.Chromium.6uEyaC --vmodule=*/chrome/browser/chromeos/account_manager/*=1,*/chromeos/components/account_manager/*=1,*/chromeos/power/auto_screen_brightness/*=1,*/forced_extensions/installation_tracker*=2,extension_downloader=2,*/feedback_uploader*=1,*/feedback_private/*=1,existing_user_controller=2,*/ash/wm/tablet_mode/*=1,auto_enrollment_controller=1,*/ui/ozone/*=1,*/ui/display/manager/chromeos/*=1,update_engine=1,component_updater_service=1,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2 --disable-sync --disable-extensions --enable-surface-synchronization --ui-compositor-memory-limit-when-visible-mb=144 GPU device 0: VENDOR = 0x0 (ARM), DEVICE = 0x0 (Mali-T860) GPU Attributes: amd_switchable : False can_support_threaded_texture_mailbox: False direct_rendering_version: encrypted_only : False gl_extensions : GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisampled_render_to_texture GL_EXT_multisampled_render_to_texture2 GL_OES_surfaceless_context GL_OES_texture_stencil8 GL_EXT_shader_pixel_local_storage GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_ARM_mali_program_binary GL_EXT_sRGB GL_EXT_sRGB_write_control GL_EXT_texture_sRGB_decode GL_EXT_texture_sRGB_R8 GL_EXT_texture_sRGB_RG8 GL_KHR_blend_equation_advanced GL_KHR_blend_equation_advanced_coherent GL_OES_texture_storage_multisample_2d_array GL_OES_shader_image_atomic GL_EXT_robustness GL_EXT_draw_buffers_indexed GL_OES_draw_buffers_indexed GL_EXT_texture_border_clamp GL_OES_texture_border_clamp GL_EXT_texture_cube_map_array GL_OES_texture_cube_map_array GL_OES_sample_variables GL_OES_sample_shading GL_OES_shader_multisample_interpolation GL_EXT_shader_io_blocks GL_OES_shader_io_blocks GL_EXT_tessellation_shader GL_OES_tessellation_shader GL_EXT_primitive_bounding_box GL_OES_primitive_bounding_box GL_EXT_geometry_shader GL_OES_geometry_shader GL_ANDROID_extension_pack_es31a GL_EXT_gpu_shader5 GL_OES_gpu_shader5 GL_EXT_texture_buffer GL_OES_texture_buffer GL_EXT_copy_image GL_OES_copy_image GL_EXT_shader_non_constant_global_initializers GL_EXT_color_buffer_half_float GL_EXT_color_buffer_float GL_EXT_YUV_target GL_OVR_multiview GL_OVR_multiview2 GL_OVR_multiview_multisampled_render_to_texture GL_KHR_robustness GL_KHR_robust_buffer_access_behavior GL_EXT_draw_elements_base_vertex GL_OES_draw_elements_base_vertex GL_EXT_buffer_storage gl_renderer : Mali-T860 gl_reset_notification_strategy: 33362 gl_vendor : ARM gl_version : OpenGL ES 3.2 v1.r26p0-01rel0.8597fc75a24d2d76acfad4df6d4fe6aa gl_ws_extensions : EGL_KHR_partial_update EGL_EXT_swap_buffers_with_damage EGL_KHR_swap_buffers_with_damage EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_image_pixmap EGL_ANDROID_native_fence_sync EGL_EXT_image_flush_external EGL_KHR_config_attribs EGL_KHR_image EGL_KHR_image_base EGL_KHR_fence_sync EGL_KHR_wait_sync EGL_KHR_gl_colorspace EGL_KHR_get_all_proc_addresses EGL_IMG_context_priority EGL_KHR_no_config_context EGL_EXT_pixel_format_float EGL_ARM_pixmap_multisample_discard EGL_ARM_implicit_external_sync EGL_KHR_gl_texture_2D_image EGL_KHR_gl_renderbuffer_image EGL_KHR_create_context EGL_KHR_surfaceless_context EGL_KHR_gl_texture_cubemap_image EGL_EXT_image_gl_colorspace EGL_EXT_create_context_robustness gl_ws_vendor : ARM gl_ws_version : 1.4 Midgard-"r26p0-01rel0" in_process_gpu : False initialization_time : 0.039993 jpeg_decode_accelerator_supported: False max_framerate_denominator: 1 max_framerate_numerator: 30 max_msaa_samples : 16 max_resolution_height: 1088 max_resolution_width: 1920 min_resolution_height: 48 min_resolution_width: 48 oop_rasterization_supported: True optimus : False passthrough_cmd_decoder: False pixel_shader_version: 3.20 process_crash_count : 0 profile : 1 sandboxed : True software_rendering : False vertex_shader_version: 3.20 video_decode_accelerator_flags: 0 Feature Status: 2d_canvas : enabled flash_3d : enabled flash_stage3d : enabled flash_stage3d_baseline: enabled gpu_compositing : enabled multiple_raster_threads: enabled_force_on oop_rasterization : unavailable_off protected_video_decode: unavailable_off rasterization : unavailable_off skia_renderer : disabled_off surface_control : disabled_off surface_synchronization: enabled_on video_decode : enabled viz_display_compositor: disabled_off viz_hit_test_surface_layer: enabled_on webgl : enabled webgl2 : enabled Driver Bug Workarounds: clear_uniforms_before_first_program_use disable_discard_framebuffer disable_non_empty_post_sub_buffers_for_onscreen_surfaces disable_program_caching_for_transform_feedback scalarize_vec_and_mat_constructor_args use_virtualized_gl_contexts disabled_extension__gl__khr_blend_equation_advanced disabled_extension__gl__khr_blend_equation_advanced_coherent DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[245 processes] DEBUG:root:Running 'cryptohome-path user '$guest'' DEBUG:root:"cryptohome-path user '$guest'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/loop1 /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/user ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/u-14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/u-14401d187d9f3a48a62416d2a9132343a576a7d4/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/user/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /run/daemon-store/usb_bouncer/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 DEBUG:root:Running 'grep /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Running 'cryptohome-path system '$guest'' DEBUG:root:"cryptohome-path system '$guest'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/loop1 /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/user ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/u-14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/u-14401d187d9f3a48a62416d2a9132343a576a7d4/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /home/chronos/user/MyFiles/Downloads ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 /dev/loop1 /run/daemon-store/usb_bouncer/14401d187d9f3a48a62416d2a9132343a576a7d4 ext4 rw,nosuid,nodev,noexec,relatime,block_validity,delalloc,nojournal_checksum,barrier,user_xattr,acl 0 0 DEBUG:root:Running 'grep /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[245 processes] DEBUG:root:['sh', '-c', '/bin/ps --no-headers -A -o pid,ppid,args:4096,state'] DEBUG:root:ListProcesses(<predicate>)->[245 processes] INFO:root:Closing browser (pid=5827) ... INFO:root:(Re)starting the ui (logs the user out) DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'systemctl'] DEBUG:root:['sh', '-c', 'status ui'] DEBUG:root:IsServiceRunning(ui)->True DEBUG:root:sh -c restart ui DEBUG:root:['sh', '-c', 'restart ui'] DEBUG:root: > stdout=[ui start/running, process 6190 ], stderr=[] DEBUG:root:sh -c cryptohome-path user '$guest' DEBUG:root:['sh', '-c', "cryptohome-path user '$guest'"] DEBUG:root: > stdout=[/home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4'] DEBUG:root: > stdout=[], stderr=[df: /run/cryptohome/ephemeral_mount/14401d187d9f3a48a62416d2a9132343a576a7d4: No such file or directory ] DEBUG:root:sh -c cryptohome-path user '$guest' DEBUG:root:['sh', '-c', "cryptohome-path user '$guest'"] DEBUG:root: > stdout=[/home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 ], stderr=[] DEBUG:root:sh -c /bin/df --output=source,target /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 DEBUG:root:['sh', '-c', '/bin/df --output=source,target /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4'] DEBUG:root: > stdout=[Filesystem Mounted on /dev/mmcblk0p1 /home ], stderr=[] INFO:root:Browser is closed. DEBUG:root:Running 'cryptohome-path user '$guest'' DEBUG:root:"cryptohome-path user '$guest'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 DEBUG:root:Running 'grep /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/user/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Running 'cryptohome-path system '$guest'' DEBUG:root:"cryptohome-path system '$guest'" DEBUG:root:Running 'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'cat /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:Active cryptohome mounts: /dev/root / ext2 rw,relatime,block_validity,barrier,user_xattr,acl 0 0 devtmpfs /dev devtmpfs rw,nosuid,noexec,relatime,size=1951208k,nr_inodes=487802,mode=755 0 0 none /proc proc rw,nosuid,nodev,noexec,relatime 0 0 none /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0 tmp /tmp tmpfs rw,nodev,relatime 0 0 run /run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 debugfs /sys/kernel/debug debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 shmfs /dev/shm tmpfs rw,nosuid,nodev,noexec,relatime 0 0 devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0 configfs /sys/kernel/config configfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /mnt/stateful_partition ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p8 /usr/share/oem ext4 ro,nosuid,nodev,noexec,relatime,data=ordered 0 0 /dev/mmcblk0p1 /home ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mapper/encstateful /mnt/stateful_partition/encrypted ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /var ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 /dev/mapper/encstateful /home/chronos ext4 rw,nosuid,nodev,noexec,noatime,discard,commit=600,data=ordered 0 0 run /var/run tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /var/lock tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 run /run/daemon-store/usb_bouncer tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 media /media tmpfs rw,nosuid,nodev,noexec,relatime 0 0 /dev/mmcblk0p1 /usr/local ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/db/pkg ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 /dev/mmcblk0p1 /var/lib/portage ext4 rw,nosuid,nodev,noexec,noatime,resgid=20119,commit=600,data=ordered 0 0 pstore /sys/fs/pstore pstore rw,nosuid,nodev,noexec,relatime 0 0 none /sys/fs/cgroup tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 cgroup /sys/fs/cgroup/cpu cgroup rw,nosuid,nodev,noexec,relatime,cpu 0 0 cgroup /sys/fs/cgroup/freezer cgroup rw,nosuid,nodev,noexec,relatime,freezer 0 0 cgroup /sys/fs/cgroup/devices cgroup rw,nosuid,nodev,noexec,relatime,devices 0 0 cgroup /sys/fs/cgroup/cpuacct cgroup rw,nosuid,nodev,noexec,relatime,cpuacct 0 0 cgroup /sys/fs/cgroup/cpuset cgroup rw,nosuid,nodev,noexec,relatime,cpuset,noprefix 0 0 cgroup /sys/fs/cgroup/schedtune cgroup rw,nosuid,nodev,noexec,relatime,schedtune 0 0 imageloader /run/imageloader tmpfs rw,nosuid,nodev,noexec,relatime,mode=755 0 0 tracefs /sys/kernel/debug/tracing tracefs rw,nosuid,nodev,noexec,relatime 0 0 debugfs /run/debugfs_gpu debugfs rw,nosuid,nodev,noexec,relatime,gid=605,mode=750 0 0 /dev/mmcblk0p1 /opt/google/chrome ext4 rw,nodev,noatime,resgid=20119,commit=600,data=ordered 0 0 DEBUG:root:Running 'grep /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' DEBUG:root:'grep /home/root/14401d187d9f3a48a62416d2a9132343a576a7d4 /proc/$(pgrep cryptohomed)/mounts' INFO:root:Tests succeeded in 24 seconds. 21:51:07: INFO: RunCommand: ssh -p 22 '-oConnectionAttempts=4' '-oUserKnownHostsFile=/dev/null' '-oProtocol=2' '-oConnectTimeout=30' '-oServerAliveCountMax=3' '-oStrictHostKeyChecking=no' '-oServerAliveInterval=10' '-oNumberOfPasswordPrompts=0' '-oIdentitiesOnly=yes' -i /b/swarming/w/itXOCSnJ/ssh-tmp9ndebf/testing_rsa root@variable_chromeos_device_hostname -- rm -rf /usr/local/cros_test 21:51:07: INFO: ./tmpbkmp3K.sh exited with status code 0. 21:51:07: INFO: Fetching /var/log/ to /b/swarming/w/ioelfl5j 21:51:07: INFO: Time elapsed: 0:00:52.196026 INFO:root:Test exitted with 0. 2019-04-23 14:51:13,914 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmp_AY9ts/4464fed966c6c810'] 2019-04-23 14:51:13,914 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmp_AY9ts/4464fed966c6c810/output.json'] 2019-04-23 14:51:13,914 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/95f307/bin/python /b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --build-properties {"bot_id": "gce-trusty-e833d7b0-us-west1-b-1jgm", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556055819654955, "id": "8915350928808475344", "project": "chromium", "tags": ["build_address:luci.chromium.ci/chromeos-kevin-rel/6127", "builder:chromeos-kevin-rel", "buildset:commit/git/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080780991083070320", "scheduler_job_id:chromium/chromeos-kevin-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-kevin-rel", "buildnumber": 6127, "got_angle_revision": "83740f9795844dd947543e03fd9a69155054b79b", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "got_revision_cp": "refs/heads/master@{#653380}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "33a2e1abff72ef2a7955b2ee942286901c638544", "got_v8_revision_cp": "refs/heads/7.6.6@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.chromiumos", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa"} --summary-json /b/s/w/ir/tmp/t/tmp0HKcTj.json --task-output-dir /b/s/w/ir/tmp/t/tmp_AY9ts -o /b/s/w/ir/tmp/t/tmpmScHkS.json /b/s/w/ir/tmp/t/tmp_AY9ts/4464fed966c6c810/output.json Running ['/b/s/w/ir/cache/vpython/95f307/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"bot_id": "gce-trusty-e833d7b0-us-west1-b-1jgm", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556055819654955, "id": "8915350928808475344", "project": "chromium", "tags": ["build_address:luci.chromium.ci/chromeos-kevin-rel/6127", "builder:chromeos-kevin-rel", "buildset:commit/git/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080780991083070320", "scheduler_job_id:chromium/chromeos-kevin-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-kevin-rel", "buildnumber": 6127, "got_angle_revision": "83740f9795844dd947543e03fd9a69155054b79b", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "got_revision_cp": "refs/heads/master@{#653380}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "33a2e1abff72ef2a7955b2ee942286901c638544", "got_v8_revision_cp": "refs/heads/7.6.6@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.chromiumos", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa"}', '--summary-json', '/b/s/w/ir/tmp/t/tmp0HKcTj.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp_AY9ts', '-o', '/b/s/w/ir/tmp/t/tmpmScHkS.json', '/b/s/w/ir/tmp/t/tmp_AY9ts/4464fed966c6c810/output.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/95f307/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"bot_id": "gce-trusty-e833d7b0-us-west1-b-1jgm", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556055819654955, "id": "8915350928808475344", "project": "chromium", "tags": ["build_address:luci.chromium.ci/chromeos-kevin-rel/6127", "builder:chromeos-kevin-rel", "buildset:commit/git/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080780991083070320", "scheduler_job_id:chromium/chromeos-kevin-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "chromeos-kevin-rel", "buildnumber": 6127, "got_angle_revision": "83740f9795844dd947543e03fd9a69155054b79b", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa", "got_revision_cp": "refs/heads/master@{#653380}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "33a2e1abff72ef2a7955b2ee942286901c638544", "got_v8_revision_cp": "refs/heads/7.6.6@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.chromiumos", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "1ad7b466dba8a6b8bd5d295dda25866702d7d7aa"}', '--summary-json', '/b/s/w/ir/tmp/t/tmp0HKcTj.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp_AY9ts', '-o', '/b/s/w/ir/tmp/t/tmpmScHkS.json', '/b/s/w/ir/tmp/t/tmp_AY9ts/4464fed966c6c810/output.json'] returned exit code 0