builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1504144605.29 results: success (0) revision: ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.285459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.286361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.286653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.302107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.302451) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-30 18:56:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-08-30 18:56:45 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.435113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.435421) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.485885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:45.486226) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-30 18:56:45,676 truncating revision to first 12 chars 2017-08-30 18:56:45,676 Setting DEBUG logging. 2017-08-30 18:56:45,676 attempt 1/10 2017-08-30 18:56:45,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ac9086908c1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-30 18:56:46,163 unpacking tar archive at: mozilla-beta-ac9086908c1e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.795517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:46.300518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:46.300867) ========= script_repo_revision: ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:46.305318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:46.305610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-30 18:56:46.325601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-30 18:56:46.325968) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:46 INFO - MultiFileLogger online at 20170830 18:56:46 in /builds/slave/test 18:56:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 18:56:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:56:46 INFO - {'append_to_log': False, 18:56:46 INFO - 'base_work_dir': '/builds/slave/test', 18:56:46 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:56:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:56:46 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:56:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:46 INFO - 'code_coverage': False, 18:56:46 INFO - 'config_files': ('talos/linux_config.py',), 18:56:46 INFO - 'default_actions': ('clobber', 18:56:46 INFO - 'read-buildbot-config', 18:56:46 INFO - 'download-and-extract', 18:56:46 INFO - 'populate-webroot', 18:56:46 INFO - 'create-virtualenv', 18:56:46 INFO - 'install', 18:56:46 INFO - 'setup-mitmproxy', 18:56:46 INFO - 'run-tests'), 18:56:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:46 INFO - 'disable_ccov_upload': False, 18:56:46 INFO - 'download_minidump_stackwalk': True, 18:56:46 INFO - 'download_symbols': 'ondemand', 18:56:46 INFO - 'enable_stylo': False, 18:56:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:46 INFO - 'gecko_profile': False, 18:56:46 INFO - 'gecko_profile_interval': 0, 18:56:46 INFO - 'installer_path': 'installer.exe', 18:56:46 INFO - 'log_level': 'info', 18:56:46 INFO - 'log_name': 'talos', 18:56:46 INFO - 'log_to_console': True, 18:56:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:46 INFO - 'opt_config_files': (), 18:56:46 INFO - 'pip_index': False, 18:56:46 INFO - 'suite': 'dromaeojs-e10s', 18:56:46 INFO - 'system_bits': '32', 18:56:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:46 INFO - 'title': 'talos-linux64-ix-075', 18:56:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:46 INFO - 'use_talos_json': True, 18:56:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:56:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:46 INFO - 'work_dir': 'build'} 18:56:46 INFO - [mozharness: 2017-08-31 01:56:46.618895Z] Running clobber step. 18:56:46 INFO - Running pre-action listener: _resource_record_pre_action 18:56:46 INFO - Running main action method: clobber 18:56:46 INFO - rmtree: /builds/slave/test/build 18:56:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:56:47 INFO - Running post-action listener: _resource_record_post_action 18:56:47 INFO - [mozharness: 2017-08-31 01:56:47.651627Z] Finished clobber step (success) 18:56:47 INFO - [mozharness: 2017-08-31 01:56:47.651742Z] Running read-buildbot-config step. 18:56:47 INFO - Running pre-action listener: _resource_record_pre_action 18:56:47 INFO - Running main action method: read_buildbot_config 18:56:47 INFO - Using buildbot properties: 18:56:47 INFO - { 18:56:47 INFO - "project": "", 18:56:47 INFO - "product": "firefox", 18:56:47 INFO - "who": "ryanvm@gmail.com", 18:56:47 INFO - "installer_path": "public/build/target.tar.bz2", 18:56:47 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:56:47 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:56:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:56:47 INFO - "stage_platform": "linux64", 18:56:47 INFO - "basedir": "/builds/slave/test", 18:56:47 INFO - "buildnumber": 70, 18:56:47 INFO - "platform": "ubuntu64_hw", 18:56:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:56:47 INFO - "slavebuilddir": "test", 18:56:47 INFO - "taskId": "FE3QIMgLSnuyCQWBU-LvbA", 18:56:47 INFO - "branch": "mozilla-beta", 18:56:47 INFO - "script_repo_revision": "production", 18:56:47 INFO - "revision": "ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd", 18:56:47 INFO - "slavename": "talos-linux64-ix-075", 18:56:47 INFO - "repo_path": "releases/mozilla-beta" 18:56:47 INFO - } 18:56:47 INFO - Finding installer, test and symbols from parent task. 18:56:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FE3QIMgLSnuyCQWBU-LvbA'}, attempt #1 18:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FE3QIMgLSnuyCQWBU-LvbA'}, attempt #1 18:56:48 INFO - Task dependencies: JUIHbNvwRIuCqm98TYRSyw 18:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw'}, attempt #1 18:56:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 18:56:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.test_packages.json 18:56:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.crashreporter-symbols.zip 18:56:49 INFO - Running post-action listener: _resource_record_post_action 18:56:49 INFO - [mozharness: 2017-08-31 01:56:49.009720Z] Finished read-buildbot-config step (success) 18:56:49 INFO - [mozharness: 2017-08-31 01:56:49.010054Z] Running download-and-extract step. 18:56:49 INFO - Running pre-action listener: _resource_record_pre_action 18:56:49 INFO - Running main action method: download_and_extract 18:56:49 INFO - mkdir: /builds/slave/test/build/tests 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - trying https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.test_packages.json 18:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:56:49 INFO - Downloaded 989 bytes. 18:56:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:56:49 INFO - Using the following test package requirements: 18:56:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:56:49 INFO - u'common': [u'target.common.tests.zip'], 18:56:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:56:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:56:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:56:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:56:49 INFO - u'mozbase': [u'target.common.tests.zip'], 18:56:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:56:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:56:49 INFO - u'web-platform': [u'target.common.tests.zip', 18:56:49 INFO - u'target.web-platform.tests.tar.gz'], 18:56:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:56:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:56:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip 18:56:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:56:49 INFO - Fetch https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip into memory 18:56:50 INFO - Content-Length response header: 72857670 18:56:50 INFO - Bytes received: 72857670 18:57:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip 18:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.common.tests.zip into memory 18:57:03 INFO - Content-Length response header: 72857670 18:57:03 INFO - Bytes received: 72857670 18:57:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.talos.tests.zip 18:57:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:57:15 INFO - Fetch https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.talos.tests.zip into memory 18:57:16 INFO - Content-Length response header: 14496472 18:57:16 INFO - Bytes received: 14496472 18:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:16 INFO - trying https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 18:57:16 INFO - Downloading https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:57:17 INFO - Downloaded 54202330 bytes. 18:57:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 18:57:17 INFO - mkdir: /builds/slave/test/properties 18:57:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:17 INFO - Contents: 18:57:17 INFO - build_url:https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 18:57:17 INFO - Running post-action listener: _resource_record_post_action 18:57:17 INFO - Running post-action listener: set_extra_try_arguments 18:57:17 INFO - [mozharness: 2017-08-31 01:57:17.839696Z] Finished download-and-extract step (success) 18:57:17 INFO - [mozharness: 2017-08-31 01:57:17.839793Z] Running populate-webroot step. 18:57:17 INFO - Running pre-action listener: _resource_record_pre_action 18:57:17 INFO - Running main action method: populate_webroot 18:57:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:57:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:57:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:57:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:57:17 INFO - 'tests': ['damp', 'tps']}, 18:57:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:57:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:57:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:57:17 INFO - 'other-e10s': {'tests': ['a11yr', 18:57:17 INFO - 'ts_paint', 18:57:17 INFO - 'tpaint', 18:57:17 INFO - 'sessionrestore', 18:57:17 INFO - 'sessionrestore_many_windows', 18:57:17 INFO - 'sessionrestore_no_auto_restore', 18:57:17 INFO - 'tabpaint']}, 18:57:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:57:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:57:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:57:17 INFO - 'talos_options': ['--mitmproxy', 18:57:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:57:17 INFO - '--firstNonBlankPaint'], 18:57:17 INFO - 'tests': ['quantum_pageload_google', 18:57:17 INFO - 'quantum_pageload_youtube', 18:57:17 INFO - 'quantum_pageload_amazon', 18:57:17 INFO - 'quantum_pageload_facebook']}, 18:57:17 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:57:17 INFO - 'talos_options': ['--stylo', 18:57:17 INFO - '--mitmproxy', 18:57:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:57:17 INFO - '--firstNonBlankPaint'], 18:57:17 INFO - 'tests': ['quantum_pageload_google', 18:57:17 INFO - 'quantum_pageload_youtube', 18:57:17 INFO - 'quantum_pageload_amazon', 18:57:17 INFO - 'quantum_pageload_facebook']}, 18:57:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:57:17 INFO - 'tsvgr_opacity', 18:57:17 INFO - 'tart', 18:57:17 INFO - 'tscrollx', 18:57:17 INFO - 'cart', 18:57:17 INFO - 'tsvg_static']}, 18:57:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:57:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:57:17 INFO - 'talos_options': ['--stylo', 18:57:17 INFO - '--stylo-threads=1', 18:57:17 INFO - '--mitmproxy', 18:57:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:57:17 INFO - '--firstNonBlankPaint'], 18:57:17 INFO - 'tests': ['tp6_google', 18:57:17 INFO - 'tp6_youtube', 18:57:17 INFO - 'tp6_amazon', 18:57:17 INFO - 'tp6_facebook']}, 18:57:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:57:17 INFO - 'talos_options': ['--xperf_path', 18:57:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:17 INFO - 'tests': ['tp5n']}}} 18:57:17 INFO - Running post-action listener: _resource_record_post_action 18:57:17 INFO - [mozharness: 2017-08-31 01:57:17.848441Z] Finished populate-webroot step (success) 18:57:17 INFO - [mozharness: 2017-08-31 01:57:17.848532Z] Running create-virtualenv step. 18:57:17 INFO - Running pre-action listener: _resource_record_pre_action 18:57:17 INFO - Running main action method: create_virtualenv 18:57:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:57:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:57:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:17 INFO - Using real prefix '/usr' 18:57:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:20 INFO - Installing pip.................done. 18:57:20 INFO - Return code: 0 18:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:57:20 INFO - Reading from file tmpfile_stdout 18:57:20 INFO - Output received: 18:57:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:57:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:57:20 INFO - Using env: {'DISPLAY': ':0', 18:57:20 INFO - 'HOME': '/home/cltbld', 18:57:20 INFO - 'LANG': 'en_US.UTF-8', 18:57:20 INFO - 'LANGUAGE': 'en_US:en', 18:57:20 INFO - 'LOGNAME': 'cltbld', 18:57:20 INFO - 'MAIL': '/var/mail/cltbld', 18:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:20 INFO - 'MOZ_NO_REMOTE': '1', 18:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:20 INFO - 'NO_EM_RESTART': '1', 18:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:20 INFO - 'PWD': '/builds/slave/test', 18:57:20 INFO - 'SHELL': '/bin/bash', 18:57:20 INFO - 'SHLVL': '1', 18:57:20 INFO - 'TERM': 'linux', 18:57:20 INFO - 'TMOUT': '86400', 18:57:20 INFO - 'USER': 'cltbld', 18:57:20 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:20 INFO - '_': '/tools/buildbot/bin/python'} 18:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:57:20 INFO - Cleaning up... 18:57:20 INFO - Return code: 0 18:57:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:57:20 INFO - Using env: {'DISPLAY': ':0', 18:57:20 INFO - 'HOME': '/home/cltbld', 18:57:20 INFO - 'LANG': 'en_US.UTF-8', 18:57:20 INFO - 'LANGUAGE': 'en_US:en', 18:57:20 INFO - 'LOGNAME': 'cltbld', 18:57:20 INFO - 'MAIL': '/var/mail/cltbld', 18:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:20 INFO - 'MOZ_NO_REMOTE': '1', 18:57:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:20 INFO - 'NO_EM_RESTART': '1', 18:57:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:20 INFO - 'PWD': '/builds/slave/test', 18:57:20 INFO - 'SHELL': '/bin/bash', 18:57:20 INFO - 'SHLVL': '1', 18:57:20 INFO - 'TERM': 'linux', 18:57:20 INFO - 'TMOUT': '86400', 18:57:20 INFO - 'USER': 'cltbld', 18:57:20 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:20 INFO - '_': '/tools/buildbot/bin/python'} 18:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:21 INFO - Downloading/unpacking psutil>=3.1.1 18:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:22 INFO - Installing collected packages: psutil 18:57:22 INFO - Running setup.py install for psutil 18:57:22 INFO - building 'psutil._psutil_linux' extension 18:57:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:57:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:57:22 INFO - building 'psutil._psutil_posix' extension 18:57:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:57:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:22 INFO - Successfully installed psutil 18:57:22 INFO - Cleaning up... 18:57:22 INFO - Return code: 0 18:57:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:57:22 INFO - Using env: {'DISPLAY': ':0', 18:57:22 INFO - 'HOME': '/home/cltbld', 18:57:22 INFO - 'LANG': 'en_US.UTF-8', 18:57:22 INFO - 'LANGUAGE': 'en_US:en', 18:57:22 INFO - 'LOGNAME': 'cltbld', 18:57:22 INFO - 'MAIL': '/var/mail/cltbld', 18:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:22 INFO - 'MOZ_NO_REMOTE': '1', 18:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:22 INFO - 'NO_EM_RESTART': '1', 18:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:22 INFO - 'PWD': '/builds/slave/test', 18:57:22 INFO - 'SHELL': '/bin/bash', 18:57:22 INFO - 'SHLVL': '1', 18:57:22 INFO - 'TERM': 'linux', 18:57:22 INFO - 'TMOUT': '86400', 18:57:22 INFO - 'USER': 'cltbld', 18:57:22 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:22 INFO - '_': '/tools/buildbot/bin/python'} 18:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:57:24 INFO - Installing collected packages: mozsystemmonitor 18:57:24 INFO - Running setup.py install for mozsystemmonitor 18:57:24 INFO - Successfully installed mozsystemmonitor 18:57:24 INFO - Cleaning up... 18:57:24 INFO - Return code: 0 18:57:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:57:24 INFO - Using env: {'DISPLAY': ':0', 18:57:24 INFO - 'HOME': '/home/cltbld', 18:57:24 INFO - 'LANG': 'en_US.UTF-8', 18:57:24 INFO - 'LANGUAGE': 'en_US:en', 18:57:24 INFO - 'LOGNAME': 'cltbld', 18:57:24 INFO - 'MAIL': '/var/mail/cltbld', 18:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:24 INFO - 'MOZ_NO_REMOTE': '1', 18:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:24 INFO - 'NO_EM_RESTART': '1', 18:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:24 INFO - 'PWD': '/builds/slave/test', 18:57:24 INFO - 'SHELL': '/bin/bash', 18:57:24 INFO - 'SHLVL': '1', 18:57:24 INFO - 'TERM': 'linux', 18:57:24 INFO - 'TMOUT': '86400', 18:57:24 INFO - 'USER': 'cltbld', 18:57:24 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:24 INFO - '_': '/tools/buildbot/bin/python'} 18:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:25 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:25 INFO - warning: no files found matching '*.txt' 18:57:25 INFO - no previously-included directories found matching 'build' 18:57:25 INFO - no previously-included directories found matching 'dist' 18:57:25 INFO - no previously-included directories found matching '.git*' 18:57:25 INFO - Installing collected packages: jsonschema, functools32 18:57:25 INFO - Running setup.py install for functools32 18:57:25 INFO - warning: no files found matching '*.txt' 18:57:25 INFO - no previously-included directories found matching 'build' 18:57:25 INFO - no previously-included directories found matching 'dist' 18:57:25 INFO - no previously-included directories found matching '.git*' 18:57:26 INFO - Successfully installed jsonschema functools32 18:57:26 INFO - Cleaning up... 18:57:26 INFO - Return code: 0 18:57:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:57:26 INFO - Using env: {'DISPLAY': ':0', 18:57:26 INFO - 'HOME': '/home/cltbld', 18:57:26 INFO - 'LANG': 'en_US.UTF-8', 18:57:26 INFO - 'LANGUAGE': 'en_US:en', 18:57:26 INFO - 'LOGNAME': 'cltbld', 18:57:26 INFO - 'MAIL': '/var/mail/cltbld', 18:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:26 INFO - 'MOZ_NO_REMOTE': '1', 18:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:26 INFO - 'NO_EM_RESTART': '1', 18:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:26 INFO - 'PWD': '/builds/slave/test', 18:57:26 INFO - 'SHELL': '/bin/bash', 18:57:26 INFO - 'SHLVL': '1', 18:57:26 INFO - 'TERM': 'linux', 18:57:26 INFO - 'TMOUT': '86400', 18:57:26 INFO - 'USER': 'cltbld', 18:57:26 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:26 INFO - '_': '/tools/buildbot/bin/python'} 18:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:57:26 INFO - Cleaning up... 18:57:26 INFO - Return code: 0 18:57:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:57:26 INFO - Using env: {'DISPLAY': ':0', 18:57:26 INFO - 'HOME': '/home/cltbld', 18:57:26 INFO - 'LANG': 'en_US.UTF-8', 18:57:26 INFO - 'LANGUAGE': 'en_US:en', 18:57:26 INFO - 'LOGNAME': 'cltbld', 18:57:26 INFO - 'MAIL': '/var/mail/cltbld', 18:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:26 INFO - 'MOZ_NO_REMOTE': '1', 18:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:26 INFO - 'NO_EM_RESTART': '1', 18:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:26 INFO - 'PWD': '/builds/slave/test', 18:57:26 INFO - 'SHELL': '/bin/bash', 18:57:26 INFO - 'SHLVL': '1', 18:57:26 INFO - 'TERM': 'linux', 18:57:26 INFO - 'TMOUT': '86400', 18:57:26 INFO - 'USER': 'cltbld', 18:57:26 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:26 INFO - '_': '/tools/buildbot/bin/python'} 18:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:28 INFO - Downloading docopt-0.6.1.tar.gz 18:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:28 INFO - Running setup.py install for blobuploader 18:57:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:28 INFO - Running setup.py install for requests 18:57:28 INFO - Running setup.py install for docopt 18:57:28 INFO - Successfully installed blobuploader requests docopt 18:57:28 INFO - Cleaning up... 18:57:28 INFO - Return code: 0 18:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:28 INFO - Using env: {'DISPLAY': ':0', 18:57:28 INFO - 'HOME': '/home/cltbld', 18:57:28 INFO - 'LANG': 'en_US.UTF-8', 18:57:28 INFO - 'LANGUAGE': 'en_US:en', 18:57:28 INFO - 'LOGNAME': 'cltbld', 18:57:28 INFO - 'MAIL': '/var/mail/cltbld', 18:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:28 INFO - 'MOZ_NO_REMOTE': '1', 18:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:28 INFO - 'NO_EM_RESTART': '1', 18:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:28 INFO - 'PWD': '/builds/slave/test', 18:57:28 INFO - 'SHELL': '/bin/bash', 18:57:28 INFO - 'SHLVL': '1', 18:57:28 INFO - 'TERM': 'linux', 18:57:28 INFO - 'TMOUT': '86400', 18:57:28 INFO - 'USER': 'cltbld', 18:57:28 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:28 INFO - '_': '/tools/buildbot/bin/python'} 18:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:28 INFO - Running setup.py (path:/tmp/pip-aE_4j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:29 INFO - Running setup.py (path:/tmp/pip-o8GZVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:29 INFO - Running setup.py (path:/tmp/pip-85Rquf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:29 INFO - Running setup.py (path:/tmp/pip-4En9RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:29 INFO - Running setup.py (path:/tmp/pip-Th3xy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:29 INFO - Running setup.py (path:/tmp/pip-bgIFxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:29 INFO - Running setup.py (path:/tmp/pip-mL8RDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:29 INFO - Running setup.py (path:/tmp/pip-yvSV0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:29 INFO - Running setup.py (path:/tmp/pip-NpJJMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:29 INFO - Running setup.py (path:/tmp/pip-uKo6DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:29 INFO - Running setup.py (path:/tmp/pip-uPeIR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:29 INFO - Running setup.py (path:/tmp/pip-WnreWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:29 INFO - Running setup.py (path:/tmp/pip-1cxHKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:29 INFO - Running setup.py (path:/tmp/pip-6FCcbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:29 INFO - Running setup.py (path:/tmp/pip-GtaVSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:30 INFO - Running setup.py (path:/tmp/pip-6Up2rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:30 INFO - Running setup.py (path:/tmp/pip-wtDYQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:30 INFO - Running setup.py install for manifestparser 18:57:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Running setup.py install for mozcrash 18:57:30 INFO - Running setup.py install for mozdebug 18:57:30 INFO - Running setup.py install for mozdevice 18:57:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Running setup.py install for mozfile 18:57:30 INFO - Running setup.py install for mozhttpd 18:57:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Running setup.py install for mozinfo 18:57:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Running setup.py install for mozInstall 18:57:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:30 INFO - Running setup.py install for mozleak 18:57:31 INFO - Running setup.py install for mozlog 18:57:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Running setup.py install for moznetwork 18:57:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Running setup.py install for mozprocess 18:57:31 INFO - Running setup.py install for mozprofile 18:57:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Running setup.py install for mozrunner 18:57:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Running setup.py install for mozscreenshot 18:57:31 INFO - Running setup.py install for moztest 18:57:31 INFO - Running setup.py install for mozversion 18:57:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:31 INFO - Cleaning up... 18:57:31 INFO - Return code: 0 18:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:31 INFO - Using env: {'DISPLAY': ':0', 18:57:31 INFO - 'HOME': '/home/cltbld', 18:57:31 INFO - 'LANG': 'en_US.UTF-8', 18:57:31 INFO - 'LANGUAGE': 'en_US:en', 18:57:31 INFO - 'LOGNAME': 'cltbld', 18:57:31 INFO - 'MAIL': '/var/mail/cltbld', 18:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:31 INFO - 'MOZ_NO_REMOTE': '1', 18:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:31 INFO - 'NO_EM_RESTART': '1', 18:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:31 INFO - 'PWD': '/builds/slave/test', 18:57:31 INFO - 'SHELL': '/bin/bash', 18:57:31 INFO - 'SHLVL': '1', 18:57:31 INFO - 'TERM': 'linux', 18:57:31 INFO - 'TMOUT': '86400', 18:57:31 INFO - 'USER': 'cltbld', 18:57:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:31 INFO - '_': '/tools/buildbot/bin/python'} 18:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:32 INFO - Running setup.py (path:/tmp/pip-JaTWyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:32 INFO - Running setup.py (path:/tmp/pip-9DeoQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:32 INFO - Running setup.py (path:/tmp/pip-fhz7cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:32 INFO - Running setup.py (path:/tmp/pip-ax7wo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:32 INFO - Running setup.py (path:/tmp/pip-df33Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:32 INFO - Running setup.py (path:/tmp/pip-SgYtid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:32 INFO - Running setup.py (path:/tmp/pip-uv4fiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:32 INFO - Running setup.py (path:/tmp/pip-5LC1II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:32 INFO - Running setup.py (path:/tmp/pip-t_1cav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:32 INFO - Running setup.py (path:/tmp/pip-gj0OJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:32 INFO - Running setup.py (path:/tmp/pip-NQYCCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:32 INFO - Running setup.py (path:/tmp/pip-92IVuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:33 INFO - Running setup.py (path:/tmp/pip-3KMUCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:33 INFO - Running setup.py (path:/tmp/pip-xhPGR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:33 INFO - Running setup.py (path:/tmp/pip-6D5MZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:33 INFO - Running setup.py (path:/tmp/pip-PFpVdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:33 INFO - Running setup.py (path:/tmp/pip-Lq5_pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:57:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:34 INFO - Downloading blessings-1.6.tar.gz 18:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:34 INFO - Installing collected packages: blessings 18:57:34 INFO - Running setup.py install for blessings 18:57:34 INFO - Successfully installed blessings 18:57:34 INFO - Cleaning up... 18:57:34 INFO - Return code: 0 18:57:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:35 INFO - Reading from file tmpfile_stdout 18:57:35 INFO - Current package versions: 18:57:35 INFO - argparse == 1.2.1 18:57:35 INFO - blessings == 1.6 18:57:35 INFO - blobuploader == 1.2.4 18:57:35 INFO - docopt == 0.6.1 18:57:35 INFO - functools32 == 3.2.3-2 18:57:35 INFO - jsonschema == 2.5.1 18:57:35 INFO - manifestparser == 1.1 18:57:35 INFO - mozInstall == 1.13 18:57:35 INFO - mozcrash == 1.0 18:57:35 INFO - mozdebug == 0.1 18:57:35 INFO - mozdevice == 0.51 18:57:35 INFO - mozfile == 1.2 18:57:35 INFO - mozhttpd == 0.7 18:57:35 INFO - mozinfo == 0.10 18:57:35 INFO - mozleak == 0.1 18:57:35 INFO - mozlog == 3.5 18:57:35 INFO - moznetwork == 0.27 18:57:35 INFO - mozprocess == 0.25 18:57:35 INFO - mozprofile == 0.28 18:57:35 INFO - mozrunner == 6.13 18:57:35 INFO - mozscreenshot == 0.1 18:57:35 INFO - mozsystemmonitor == 0.3 18:57:35 INFO - moztest == 0.8 18:57:35 INFO - mozversion == 1.4 18:57:35 INFO - psutil == 3.1.1 18:57:35 INFO - requests == 1.2.3 18:57:35 INFO - wsgiref == 0.1.2 18:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:35 INFO - Using env: {'DISPLAY': ':0', 18:57:35 INFO - 'HOME': '/home/cltbld', 18:57:35 INFO - 'LANG': 'en_US.UTF-8', 18:57:35 INFO - 'LANGUAGE': 'en_US:en', 18:57:35 INFO - 'LOGNAME': 'cltbld', 18:57:35 INFO - 'MAIL': '/var/mail/cltbld', 18:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:35 INFO - 'MOZ_NO_REMOTE': '1', 18:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:35 INFO - 'NO_EM_RESTART': '1', 18:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:35 INFO - 'PWD': '/builds/slave/test', 18:57:35 INFO - 'SHELL': '/bin/bash', 18:57:35 INFO - 'SHLVL': '1', 18:57:35 INFO - 'TERM': 'linux', 18:57:35 INFO - 'TMOUT': '86400', 18:57:35 INFO - 'USER': 'cltbld', 18:57:35 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:35 INFO - '_': '/tools/buildbot/bin/python'} 18:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:57:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:36 INFO - Installing collected packages: simplejson 18:57:36 INFO - Running setup.py install for simplejson 18:57:36 INFO - building 'simplejson._speedups' extension 18:57:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:57:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:57:37 INFO - Successfully installed simplejson 18:57:37 INFO - Cleaning up... 18:57:37 INFO - Return code: 0 18:57:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1141d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:57:37 INFO - Using env: {'DISPLAY': ':0', 18:57:37 INFO - 'HOME': '/home/cltbld', 18:57:37 INFO - 'LANG': 'en_US.UTF-8', 18:57:37 INFO - 'LANGUAGE': 'en_US:en', 18:57:37 INFO - 'LOGNAME': 'cltbld', 18:57:37 INFO - 'MAIL': '/var/mail/cltbld', 18:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:37 INFO - 'MOZ_NO_REMOTE': '1', 18:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:37 INFO - 'NO_EM_RESTART': '1', 18:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:37 INFO - 'PWD': '/builds/slave/test', 18:57:37 INFO - 'SHELL': '/bin/bash', 18:57:37 INFO - 'SHLVL': '1', 18:57:37 INFO - 'TERM': 'linux', 18:57:37 INFO - 'TMOUT': '86400', 18:57:37 INFO - 'USER': 'cltbld', 18:57:37 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:37 INFO - '_': '/tools/buildbot/bin/python'} 18:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:57:37 INFO - Cleaning up... 18:57:37 INFO - Return code: 0 18:57:37 INFO - Running post-action listener: _resource_record_post_action 18:57:37 INFO - Running post-action listener: _start_resource_monitoring 18:57:37 INFO - Starting resource monitoring. 18:57:37 INFO - [mozharness: 2017-08-31 01:57:37.701661Z] Finished create-virtualenv step (success) 18:57:37 INFO - [mozharness: 2017-08-31 01:57:37.702165Z] Running install step. 18:57:37 INFO - Running pre-action listener: _resource_record_pre_action 18:57:37 INFO - Running main action method: install 18:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:37 INFO - Reading from file tmpfile_stdout 18:57:37 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:38 INFO - Reading from file tmpfile_stdout 18:57:38 INFO - Output received: 18:57:38 INFO - Usage: mozinstall [options] installer 18:57:38 INFO - Options: 18:57:38 INFO - -h, --help show this help message and exit 18:57:38 INFO - -d DEST, --destination=DEST 18:57:38 INFO - Directory to install application into. [default: 18:57:38 INFO - "/builds/slave/test"] 18:57:38 INFO - --app=APP Application being installed. [default: firefox] 18:57:38 INFO - mkdir: /builds/slave/test/build/application 18:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:57:52 INFO - Reading from file tmpfile_stdout 18:57:52 INFO - Output received: 18:57:52 INFO - /builds/slave/test/build/application/firefox/firefox 18:57:52 INFO - Running post-action listener: _resource_record_post_action 18:57:52 INFO - [mozharness: 2017-08-31 01:57:52.832192Z] Finished install step (success) 18:57:52 INFO - [mozharness: 2017-08-31 01:57:52.832443Z] Running setup-mitmproxy step. 18:57:52 INFO - Running pre-action listener: _resource_record_pre_action 18:57:52 INFO - Running main action method: setup_mitmproxy 18:57:52 INFO - Skipping: mitmproxy is not required 18:57:52 INFO - Running post-action listener: _resource_record_post_action 18:57:52 INFO - [mozharness: 2017-08-31 01:57:52.833564Z] Finished setup-mitmproxy step (success) 18:57:52 INFO - [mozharness: 2017-08-31 01:57:52.833784Z] Running run-tests step. 18:57:52 INFO - Running pre-action listener: _resource_record_pre_action 18:57:52 INFO - Running pre-action listener: _set_gcov_prefix 18:57:52 INFO - Running main action method: run_tests 18:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:57:52 INFO - Python 2.7.3 18:57:52 INFO - Return code: 0 18:57:52 INFO - grabbing minidump binary from tooltool 18:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113eeb0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1140240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:57:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:57:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:57:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:57:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:52 INFO - Return code: 0 18:57:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:57:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:57:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:57:52 INFO - ENV: RUST_BACKTRACE is now 1 18:57:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:57:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:57:52 INFO - Using env: {'DISPLAY': ':0', 18:57:52 INFO - 'HOME': '/home/cltbld', 18:57:52 INFO - 'LANG': 'en_US.UTF-8', 18:57:52 INFO - 'LANGUAGE': 'en_US:en', 18:57:52 INFO - 'LOGNAME': 'cltbld', 18:57:52 INFO - 'MAIL': '/var/mail/cltbld', 18:57:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:52 INFO - 'MOZ_NO_REMOTE': '1', 18:57:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:52 INFO - 'NO_EM_RESTART': '1', 18:57:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:52 INFO - 'PWD': '/builds/slave/test', 18:57:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:52 INFO - 'RUST_BACKTRACE': '1', 18:57:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:57:52 INFO - 'SHELL': '/bin/bash', 18:57:52 INFO - 'SHLVL': '1', 18:57:52 INFO - 'TERM': 'linux', 18:57:52 INFO - 'TMOUT': '86400', 18:57:52 INFO - 'USER': 'cltbld', 18:57:52 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530', 18:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:52 INFO - '_': '/tools/buildbot/bin/python'} 18:57:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:57:53 INFO - mozversion application_buildid: 20170831004609 18:57:53 INFO - mozversion application_changeset: ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd 18:57:53 INFO - mozversion application_display_name: Firefox 18:57:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:53 INFO - mozversion application_name: Firefox 18:57:53 INFO - mozversion application_remotingname: firefox 18:57:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:57:53 INFO - mozversion application_vendor: Mozilla 18:57:53 INFO - mozversion application_version: 56.0 18:57:53 INFO - mozversion platform_buildid: 20170831004609 18:57:53 INFO - mozversion platform_changeset: ac9086908c1ef4f9f6e14f77bd0430a6c9609cdd 18:57:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:57:53 INFO - mozversion platform_version: 56.0 18:57:53 INFO - using testdate: 1504144673 18:57:53 INFO - actual date: 1504144673 18:57:53 INFO - starting webserver on 'localhost:44230' 18:57:53 INFO - SUITE-START | Running 2 tests 18:57:53 INFO - TEST-START | dromaeo_css 18:57:53 INFO - Initialising browser for dromaeo_css test... 18:57:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44230/getInfo.html -profile /tmp/tmpJwBSVP/profile 18:57:53 INFO - TEST-INFO | started process 31778 (/builds/slave/test/build/application/firefox/firefox http://localhost:44230/getInfo.html) 18:57:59 INFO - TEST-INFO | 31778: exit 0 18:57:59 INFO - Browser initialized. 18:57:59 INFO - Running cycle 1/1 for dromaeo_css test... 18:57:59 INFO - TEST-INFO | started process 31942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwBSVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:59 INFO - PID 31942 | 1504144679643 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 18:58:10 INFO - PID 31942 | RSS: Main: 151298048 18:58:10 INFO - PID 31942 | 19:01:08 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44230/tests/dromaeo/cssquery-ext.html) 19:01:09 INFO - PID 31942 | RSS: Main: 160608256 19:01:09 INFO - PID 31942 | 19:04:11 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-ext.html (next: http://localhost:44230/tests/dromaeo/cssquery-jquery.html) 19:04:11 INFO - PID 31942 | RSS: Main: 157908992 19:04:11 INFO - PID 31942 | 19:07:13 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44230/tests/dromaeo/cssquery-mootools.html) 19:07:13 INFO - PID 31942 | RSS: Main: 159793152 19:07:13 INFO - PID 31942 | 19:10:15 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44230/tests/dromaeo/cssquery-prototype.html) 19:10:15 INFO - PID 31942 | RSS: Main: 158212096 19:10:15 INFO - PID 31942 | 19:13:19 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44230/tests/dromaeo/cssquery-yui.html) 19:13:19 INFO - PID 31942 | RSS: Main: 161873920 19:13:19 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-yui.html (next: http://localhost:44230/tests/dromaeo/cssquery-dojo.html) 19:16:21 INFO - PID 31942 | RSS: Main: 164913152 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | __start_tp_report 19:16:21 INFO - PID 31942 | _x_x_mozilla_page_load 19:16:21 INFO - PID 31942 | _x_x_mozilla_page_load_details 19:16:21 INFO - PID 31942 | |i|pagename|runs| 19:16:21 INFO - PID 31942 | |0;dojo.html;3544.5214895989034;3582.8387722552484;3589.910252243694;3599.532060832092;3655.5796083450396;6376.458001069915;6403;6438.388353106459;6470.450011748995;6480.12518310028;6422.710978005989;6451.096846441502;6508.991106378507;6514.967425162879;6517.902231466532;5458.972705136489;5568.582356323272;5574.721263936807;5612.382637909826;5648.237487939137;5655.547556195515;5671.8014869479575;5676.091825307952;5687.886242275152;5698.6865722385255;5616.466435688623;5649.548036157118;5693.544516438696;5711;5715.771369145229;5535.750891209906;5565.972170139124;5595.916061259084;5664.26364572603;5665.093585026417;5589.077802162638;5592.217089607459;5631.324241091054;5645.971770141164;5646.802361917313;6278.87442251157;6311.242650881878;6391.680415979183;6414.93585064148;6431.5819471734185;6827.21487028993;6917.827054323682;6951.930480695179;6966.512344135913;7055.047568578228;6962.512624116314;7066.752663656747;7082.008518807371;7083.114610673666;7095.8226044348785;6499.642519661416;6515.576487528296;6539.901901471481;6604.50466215031;6605.9669701651665;7062.6821793019435;7153.284671532805;7165.176004759519;7172.605506697182;7178.318059784312;6779.593224406552;6825.522213445011;6826.863462730717;6859.759908403182;6882.655867206719;6979.825504362431;7009.684564194521;7088.149422069385;7099.219085900547;7118.679659415338;6952.548084374601;6970.895436568456;6975.162980442379;7049.295070493013;7053.188883278386;6900.447964162955;6963.1296087989;6975.058367120374;6975.6163411012885;7064.116985376828;5124.256982737482;5139.665921715076;5151.0470562945975;5151.943851510431;5153.793848246103;4577.793999270041;4581.65637577183;4611.723296602215;4630.6063984561015;4658.114958157939;6476.5466417350335;6602.108715323466;6609.5373323867825;6678.933210667831;6679.532432729759;6992.965035174791;6999.8600027999155;7042.084529011196;7060.717571297193;7074.71701131949;6531.836704082436;6593.967030164818;6600.372964568358;6616.801495955129;6629.872921603339;5796.710164491758;5821.476067153976;5893.02765043763;5898.498627616615;5902.557308201902;7016.36852683261;7160.677769500385;7174.0315057467615;7208.675609597581;7257.92742072583;6990.790276291719;7032.718691252293;7054.894176587252;7067.6112813795735;7068.787936361918;7209.6395180241825;7214.422846172189;7216.855662886818;7285.23505031964;7300.415966722756;6770.966145169243;6856.24581296067;6870.965645171742;6897.137857767779;6972.163340399185;7057.36483716468;7063.328983746535;7072.611006394698;7087.433005359662;7090.539114957512;6791.219009813737;6801.149856267966;6814.250432452525;6855;6870.3473170048765;6690.565113267622;6752.3922846944015;6766.830829229112;6768.864622707617;6786.423154031962;6747.460203183831;6753.425958793361;6759;6766.2218844831505;6770.1537307836525;6784.830379240559;6787.864242715019;6817.659117044029;6868.862622747617;6913;6651.63416012124;6684.565503242274;6742.9662851685425;6746.224184218878;6758.222804377363 19:16:21 INFO - PID 31942 | |1;ext.html;883.4478450968143;917.3074328881689;947.9146876781091;976.6093562574969;976.7606936300607;40817.3877391839;42193.789031054876;42355;42355.36466952998;42479.57520424795;40460.190796184055;40550.18899622006;40605.59394406055;40784.99999999993;40849.59150408502;7099.432045436352;7163.212046674862;7169.85660286794;7201.67592458338;7222.061132052826;7048.647567621624;7143.3570978611915;7143.499955003152;7146.106736657918;7158.105236845395;7101.8224544386285;7691.884621730678;7809.648565814552;7860.960695196516;7903.604819759018;7754.8449031019345;7827.843443131134;7859.528428294292;7862.056553213593;7862.135165131831;7696.268854458874;7738;7738.651760670783;7791.376689864797;7796;40851.38722919158;40940.590594094276;41011;41013.384799228035;41244.38133428001;3670.871519496805;3681.9447708284397;3713.3316003119426;3716.6469185427613;3718.1634132320282;32776.5083523745;33052.1736956578;33073.66926330754;33101.17247068819;33171;5122.129238029506;5171.844844654666;5200.583953283766;5222.791088356461;5235.502627250406;207597;207977;213760;218232;231652.84173579194;52715.73642131841;53064.204036939474;53082.73458632759;53096.734516327946;53127;55088.44911550913;55177.448225518034;55204.447955520736;55265;55281.1707824383;16847.241874115694;17014.659706805796;17079.743803842954;17146.82853171477;17282.22229999628;14068.226247556278;14159.221242831743;14173.858261417254;14180.078294910798;14180.432782688784;14941.925290373478;15038.248087595577;15055;15097;15375;5978.4021597839865;6064.969675151596;6065.5754097212775;6130.938690613126;6189.597676151036;1092.229977865603;1102.3496137279044;1103.3986477369854;1105.132471010253;1128.0637071230858;24877.378065548506;24994.750052499243;25111.62332565013;25233.495330093294;25274.115405960703;1205.5358686905429;1218.366449446283;1226.625879106863;1227.9508819647115;1228.791105512065;13139.42875951933;13273.269970151541;13452.596422107352;13454.260015699036;13550.59348219555;256402;268285;269754;269895;270308;55970.16044759332;56016.159757603666;56108.43891561032;56506;56542.717286414125;1517.9620509487352;1550.3411050303575;1567.686462707463;1572.4024870549347;1593.8326475719882;24471.143509977777;25000.249862575147;25045.499090017733;25098.749012510372;25412.491750164525;41078.58921410747;41089;41157.794211028755;41189.382159267036;41191.588084118775;222594;223957;223977;224557;224711;35819.82090089533;35971.28057438889;37100.81449592735;37501;37685.623143768215;47258.291125633834;47494.52505474901;48103.75948120237;48117.27824082572;48786;35316.293674126886;35552.822235888656;36050.819745901106;36081.45877811783;36141;36033.63966360407;36057.098572534844;36114.8194259027;36333.0916727084;36687;41000.179996400504;41756;41868;42757;42916.35625465683;34484.48273275853;34630.480542792386;34845.12887177739;35050.82474587611;35065.47401788924;25892.870535647202;26429;26464.470710586065;26696;26864.59703104494 19:16:21 INFO - PID 31942 | |2;jquery.html;595.5235811350921;603.5563860562486;609.4027852704347;610.9266887973442;627.3506920337451;23270.534589308223;23897.16359927403;23923.760762392372;23930.40173995651;25036.624450633208;25845;26884.327891802666;26960.865195674043;27051.86474067632;27080.458390832173;6334.049892516125;6380.457661098812;6430.839229019265;6464.676766161697;6466.094746735461;4372.672049596277;4570.611498022672;6304.62172269663;6529;6567.868642627144;6508.576942498722;6522.902156467657;6524.836879078037;6528.7714929977465;6529.379708927644;6517.3482651734685;6530.836729081787;6530.869382612369;6531.8693626127215;6537.869242615168;6086.543509236825;6097.298810636789;6097.512199024068;6103.328633850273;6109.633421994695;30752.2311942201;30947;30967.22581935447;32153.51769723456;32322.6767732322;2297.3911913342977;2352.235523454884;2363.255574494046;2365.0066971871856;2365.219477572397;19474.610507789766;19749.605007899907;19831.900840495848;19901.800981990138;20051.1979520819;2431.149097815768;2458.8524688518746;2480.1071614218868;2483.056438553356;2506.624006399055;148117.25941370224;151437;164063;169577.15211423987;170511;15546.300416481285;16187.433439829785;16607.3357065716;16892.662146756997;16955.237014334383;25337;25372;25385;25423.61864572033;25431.36421589438;11253.831192532118;11358.091352691765;11444.084473242121;11597.594084207012;11668.824967625493;9633.229341652652;10595.682129536126;10720.303180293411;10815.188860835311;10855.728606784736;8640.567971601395;9558.330916835755;9635.951820240994;9773.706788796348;9800.803983920281;2815.211740712604;2964.24411774996;3000.819950802959;3011.8192908425563;3099;1074.80696426966;1086.1745073743853;1087.0434018064052;1096.8519249901321;1111.9499622517005;21554.784452155593;21603.135874565156;21608.675869861963;21853.781462185492;22108.88945555262;1139.9886001140048;1140.321508702321;1161.8083016302385;1175.0951767139254;1179.887910648487;11523.827142592867;12018.639440816789;12116.636500904988;12180.390980450942;12267.57063502773;595544;605749;614616;624844;641666;130827.34586327008;131552.34223829012;132293.33853330673;132337.33831330782;132611;1287.2019348004296;1301.2387753164317;1322.9933850330879;1332.5469340424302;1343.9126456780277;18795.248190072245;18933.242670293585;18999.905000474908;19385.709214361515;19654.80345196587;66792.6660366695;66799.33200668126;67591;68115.31884681288;69690;80146;80472;81025.59487202526;81067.18932810596;81091;14996.400143994555;15929.761053583974;16118.355265789705;16148.273327700517;16222.67554648924;24139.275821725376;24914.377140571632;25250.36874078163;25255.87372063128;25256.873715631304;20455.181792728123;20564.691529627366;20584.382468525968;20622.38132856017;20706.275280365717;18447.53881152982;18533.166007529962;18575.535611609277;18803.05984700787;19097.331593394163;20681.965901704552;21000.68498972486;21190;21327;21366;15601.765973510179;15796.526104216891;15901;15955;16024.759628605347;19671.60656786885;20132.094055767233;20191.899040504704;20383.59232815365;20453.897730511253 19:16:21 INFO - PID 31942 | |3;mootools.html;1449.3984996226566;1502.038695235049;1522.345391481664;1540.6995635851006;1543.398074750848;15806.84193158068;16340.346386144554;16348.673026539462;16403.425880094168;16754.329826806945;16984.915075424604;17276.395326163587;17276.654466910655;17286.13569321532;17294.04882731449;2948.631421072366;2983.791134620572;3032.8331941743195;3035.575019497272;3043.087073877839;2929.4580502606977;2982.925426864335;3056.8013079149896;3057.327387974642;3057.5719399284117;2993.311538346182;3010.3678227572236;3041.406925649499;3059.082275317407;3060.4338197433435;2971.435427268823;2997.8351190684502;3018.894338698146;3027;3027.7275045246033;2849.0313293480317;2902.782291328138;2903.056506635331;2960.585518027478;2978.8361640109783;15978.680426391407;16075.517734467985;16105;16110.83889161105;16132.59668508285;8612.440191387539;8822.985356684;8865;8890.644374225023;8920.821583568357;5761.423857614247;5773.971130144322;6010.639361638316;6061.818145455643;6069.878602427971;1980.2178139634907;2046.8505779167099;2059.1969132038516;2068.338131797825;2103.2112957640884;28685.28286792826;28965.275868103254;28967.42065158706;28975;28985.275368115967;7413.481056326005;7448.255174482509;7591.696332146652;7695.268949449794;7786.844263114706;18978.24087036503;19061.428157155307;19118.139683714267;19146.904265478584;19149;8261;8668.479891206547;8680.34897382699;8688.435251708619;8701.17338852808;7902.3678105751405;7975.60121993898;8022.5186488809695;8192.795180120545;8198.795030124294;5545.195946587723;5673.262475878109;5702.201691763156;5839.824805255849;5987.072003839412;1759.366628013914;1768.823117688221;1777.2624360890086;1778.2975724588973;1814.4375243674504;970.1414248390084;981.3719219699398;982.5332966840837;987.9506024698736;1012.4988130875116;9104.362694611315;9354.953225233967;9441.386309889835;9570.473623950611;9678.274129440179;1073.3613499967507;1075.5267682219799;1085.3054045410943;1090.5201711247025;1091.2633972068822;5335.439778823167;5727.2268243787385;6008.3390827009;6085.908711369333;6087.873743357493;23185.420364491023;23514.412139696644;23515.17696880601;24671.753282466947;24702;23574.7642523576;23739.881300593388;23809.166679166145;23952;24145.396365091012;12552.497900083894;12615.936920315524;12860.421281042376;13043.543475978295;13048.673783155496;9493.24054075686;9977.45124018186;10010.549525271235;10083.294169408071;10165.085142337226;20721.274755384093;20847.166113355903;20887;21142;21231.575368492235;21385.03767330443;21452.78547214508;21544.461388464788;21582;21754.6736798945;13595.796063058864;13664.590062298146;13886.305684715522;13894.096883702527;13901.86098139046;13591.184528928296;14150.363233654305;15011.174385408907;15129.092254464767;15402.46091386841;12279.666863295944;12347.814782778445;12412.255264684149;12569.560065397667;12759.87240127624;11823.408829558659;11940.46267917963;11968.820467692818;12010.939945300217;12066.336351500751;11252.549898004316;11336.489857956576;11368.829467558158;11379.715507112389;11390.430478476208;7966.123726389977;8223.506589604644;8238.629261683358;8248.13394593583;8278.751637450887;8125.3905957052275;8213.630386632496;8333.916660833556;8411.621477033426;8422.578871056545 19:16:21 INFO - PID 31942 | |4;prototype.html;534.7807398966424;540.9432009638989;565.3244372974298;570.2017175953665;572.8940146072974;6270.341614130519;6292.653904035276;6312.274088479815;6352.5235607329405;6372.904406433907;6086;6174.228221472316;6237.875242495147;6272.811815645527;6301.6849157542165;4922.581580565657;4932.112219800426;4942.258661200831;4959.6528243023;4970.900581988376;4846.830360937368;4978.352814134176;4983.401991760976;4994.101061808873;4997.550220480156;5024.763980028889;5036.370453693288;5054.570361519275;5133.845984620468;5153.577818425334;5034.3363715819705;5054.4440111588065;5056.2162864755655;5066.06277838601;5095.210242412432;4752.881177970544;4773.68229080789;4786.52134786522;4858.222684370519;4862.975685121552;6241.21984751906;6249.96875515544;6279.497640188774;6282.811515654537;6284.27730810958;6178.38216178383;6234.719437625273;6265.592736472115;6275.372462753734;6307.558470907038;6739;6765.75243882939;6800.931990680129;6847.863042739117;6851.828704282383;5443;5487.533559647435;5492.725363731837;5496.972515137439;5504.7522861470925;7038.929610703879;7089.2556281590205;7090.298328401198;7103.549275499944;7112.751053713147;5674;5679.109809780231;5709.25779648643;5751.166080918243;5758.0787074068785;5803.100519419412;5807.506361959281;5839.766409343579;5842.620229685057;5860.443257890493;6095.207623009069;6215.378462153749;6230.7507699691505;6235.251769787655;6311.431971122529;6659.866802664016;6707.128073350531;6716.865662686719;6803.523753337219;6833.3166683331265;1919.9904000479908;1934.516370907273;1939.6799528077709;1993.920243190256;2029.786872378379;1483.1546018769413;1494.267808773693;1506.7815166800972;1507.8567536084054;1524.801775769143;6338.778142765073;6354.269259035178;6384.936150638527;6386.425221730066;6441.355864413521;6688.431483323875;6762.830929226809;6872;6881.311868813179;6927.203371612329;6224.502039836802;6292.96166132583;6402.775902843378;6417.7753778617525;6445.4199122079235;3618.3667858124722;3630.2376500935097;3639.9272014560092;3681.9263614727556;3728.7389882708494;7073.726729188693;7091.574505529685;7192.352688258082;7194.532355396883;7209.315115064165;7041.957832228596;7046.753363632351;7085.32689394517;7114.146302443636;7172.390346820474;7175.712971481186;7181.461390395742;7199.892001619875;7212.6919385796045;7221.638918054076;6841.076454678555;6859.794206173823;6944.687489062903;6960.095187625576;6987.545809522569;6773.593584384756;6785.423239024738;6814.284500127415;6865.588064716133;6885.827854303682;7093.361597456254;7113.57318560888;7142.821429464305;7182.640867956686;7227.747028853965;5282.392524859537;5292.391374991926;5311.309529761106;5344.732763361894;5350.839474815762;6676.799696008933;6811.659417029228;6845.418139458202;6920.9653951729915;6924.6537673117155;6456.257530384066;6586.595892499299;6613.702383392662;6703;6786.253512113763;6733.898991515229;6752;6762.8985565217545;6763.951587503748;6769.593824370553;6693.832654183684;6697.09589205451;6705.530612857053;6747.359000894907;6756.189257289157;6795.354441328066;6820.829479263058;6836.111305530249;6852.554583952027;6868.793936181923;6531.706073226621;6592.143021407378;6592.868142637216;6661.966690166712;6666.2333831609985 19:16:21 INFO - PID 31942 | |5;yui.html;941.2328951904198;965.7778710896492;977.062020460358;982.83783175776;1001.2340559472003;19243.23027078917;20071.899640501797;20177.899110504426;20197.09113089911;22172.445688857788;21698.132074717032;21918.342449726533;22138.33584992453;22179.889100554476;22340.776592234073;1060.8620879285681;1084.3927400655618;1087.0542627913726;1087.3910610058354;1089.2974031749516;1083.1226706367827;1094.5621751299504;1096.6655170173094;1096.9341839489616;1098.4233277529322;1016.4917541229386;1086.7717779266363;1090.2477290669412;1090.798202332571;1092.743205346747;1074.1031238915516;1075.5321435175686;1080.1466841195447;1081.2431298091328;1081.6646839479786;795.2762985683;800.2837460472903;801.1427772283658;802.0535767794;803.8392321535716;20274.797252027438;20789.16843326265;20922;21007.789922100736;21094.894525527427;18943.147558359906;19538;21288.148474061174;21832.781672183235;21832.89083554572;17492.91253543724;17571;17631.294748210057;17705.29178832845;17756.289748410047;3832.367659336206;3856.3058649443087;3856.4986551748375;3856.7107466940092;3858.1704933439164;141475.29262353622;142368.2881585596;143837.28081359525;145015;147156;16506.33974641025;16979.320827167023;17049.7442538362;17051.31794728222;17059;30880.691193087783;31889.521657175163;32104.83947580247;32121.357572848414;32134.35731285361;9036.8644470333;9056.13966673165;9067.68263110788;9149.451032938045;9159.679411220575;4528.864134075983;4597.839075632337;4649.953500464952;4667.113248482845;4669.229577119805;5649.322081350264;5749.741261643236;6213.068039794067;6503.674816259168;6505.577137486048;1261.6215135459327;1277.4698500122345;1290.5160564788205;1291.728736965229;1294.1070661243712;771.8224808294011;782.8864814601851;788.2826627768703;791.8733002719537;792.0811858244409;13140.2115873046;13906.443742250196;14045.297735113203;15511.844881551266;15539.844601554067;780.8906753054576;796.0526972902228;797.1948332184535;801.2148094867063;813.4265342933336;6412.807615771534;6448.355164483608;6780.93219067803;6807.149106361705;6813.693383797741;127417;129870;130586;133718;134135;115946;116526.41736791261;117870.4106479462;118417.40791295988;123279.3836030832;97050.51474742581;99705.50147249362;103223;104221.47889260505;106757.46621267;12155.513779449077;12250.326232057323;12295.32375719344;12360.690982725144;12430.264557664013;46163.76918115388;46894;47699;47752;47956.280655789495;62686;63257;63400.365996339446;63937.680311598146;66152.67694645983;17003.574910627332;17349.826501735326;17412.82587174163;17432.215550300014;17526.123693815513;18772.7184092236;18946.43160705181;19130.617387652448;19260.133294001524;19430.708539372205;17758.733618995466;17760.91119544394;17800.3769868054;17832.10839457996;18026.63946721032;16890.74663880018;16908.15459227009;16989.49031529056;17015.914920425814;17050.232739526502;16390.508284751475;16410.097444640658;16514.83485165133;16559.751603726196;16567.254473548477;12663.556775512812;13134.671633209246;13466.326683665973;13569.321533923461;13603.455861765815;15912.443064492687;15942.521724348288;16340.754888676442;16451.58871028234;16831.7475237874 19:16:21 INFO - PID 31942 | __end_tp_report 19:16:21 INFO - PID 31942 | __start_cc_report 19:16:21 INFO - PID 31942 | _x_x_mozilla_cycle_collect,304 19:16:21 INFO - PID 31942 | __end_cc_report 19:16:21 INFO - PID 31942 | __startTimestamp1504145781697__endTimestamp 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | ------- Summary: start ------- 19:16:21 INFO - PID 31942 | Number of tests: 6 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#0] dojo.html Cycles:165 Average:6416.62 Median:6753.43 stddev:822.52 (12.2%) stddev-sans-first:793.59 19:16:21 INFO - PID 31942 | Values: 3544.5 3582.8 3589.9 3599.5 3655.6 6376.5 6403.0 6438.4 6470.5 6480.1 6422.7 6451.1 6509.0 6515.0 6517.9 5459.0 5568.6 5574.7 5612.4 5648.2 5655.5 5671.8 5676.1 5687.9 5698.7 5616.5 5649.5 5693.5 5711.0 5715.8 5535.8 5566.0 5595.9 5664.3 5665.1 5589.1 5592.2 5631.3 5646.0 5646.8 6278.9 6311.2 6391.7 6414.9 6431.6 6827.2 6917.8 6951.9 6966.5 7055.0 6962.5 7066.8 7082.0 7083.1 7095.8 6499.6 6515.6 6539.9 6604.5 6606.0 7062.7 7153.3 7165.2 7172.6 7178.3 6779.6 6825.5 6826.9 6859.8 6882.7 6979.8 7009.7 7088.1 7099.2 7118.7 6952.5 6970.9 6975.2 7049.3 7053.2 6900.4 6963.1 6975.1 6975.6 7064.1 5124.3 5139.7 5151.0 5151.9 5153.8 4577.8 4581.7 4611.7 4630.6 4658.1 6476.5 6602.1 6609.5 6678.9 6679.5 6993.0 6999.9 7042.1 7060.7 7074.7 6531.8 6594.0 6600.4 6616.8 6629.9 5796.7 5821.5 5893.0 5898.5 5902.6 7016.4 7160.7 7174.0 7208.7 7257.9 6990.8 7032.7 7054.9 7067.6 7068.8 7209.6 7214.4 7216.9 7285.2 7300.4 6771.0 6856.2 6871.0 6897.1 6972.2 7057.4 7063.3 7072.6 7087.4 7090.5 6791.2 6801.1 6814.3 6855.0 6870.3 6690.6 6752.4 6766.8 6768.9 6786.4 6747.5 6753.4 6759.0 6766.2 6770.2 6784.8 6787.9 6817.7 6868.9 6913.0 6651.6 6684.6 6743.0 6746.2 6758.2 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#1] ext.html Cycles:180 Average:41567.07 Median:3714.99 stddev:61468.22 (1654.6%) stddev-sans-first:61564.75 19:16:21 INFO - PID 31942 | Values: 883.4 917.3 947.9 976.6 976.8 40817.4 42193.8 42355.0 42355.4 42479.6 40460.2 40550.2 40605.6 40785.0 40849.6 7099.4 7163.2 7169.9 7201.7 7222.1 7048.6 7143.4 7143.5 7146.1 7158.1 7101.8 7691.9 7809.6 7861.0 7903.6 7754.8 7827.8 7859.5 7862.1 7862.1 7696.3 7738.0 7738.7 7791.4 7796.0 40851.4 40940.6 41011.0 41013.4 41244.4 3670.9 3681.9 3713.3 3716.6 3718.2 32776.5 33052.2 33073.7 33101.2 33171.0 5122.1 5171.8 5200.6 5222.8 5235.5 207597.0 207977.0 213760.0 218232.0 231652.8 52715.7 53064.2 53082.7 53096.7 53127.0 55088.4 55177.4 55204.4 55265.0 55281.2 16847.2 17014.7 17079.7 17146.8 17282.2 14068.2 14159.2 14173.9 14180.1 14180.4 14941.9 15038.2 15055.0 15097.0 15375.0 5978.4 6065.0 6065.6 6130.9 6189.6 1092.2 1102.3 1103.4 1105.1 1128.1 24877.4 24994.8 25111.6 25233.5 25274.1 1205.5 1218.4 1226.6 1228.0 1228.8 13139.4 13273.3 13452.6 13454.3 13550.6 256402.0 268285.0 269754.0 269895.0 270308.0 55970.2 56016.2 56108.4 56506.0 56542.7 1518.0 1550.3 1567.7 1572.4 1593.8 24471.1 25000.2 25045.5 25098.7 25412.5 41078.6 41089.0 41157.8 41189.4 41191.6 222594.0 223957.0 223977.0 224557.0 224711.0 35819.8 35971.3 37100.8 37501.0 37685.6 47258.3 47494.5 48103.8 48117.3 48786.0 35316.3 35552.8 36050.8 36081.5 36141.0 36033.6 36057.1 36114.8 36333.1 36687.0 41000.2 41756.0 41868.0 42757.0 42916.4 34484.5 34630.5 34845.1 35050.8 35065.5 25892.9 26429.0 26464.5 26696.0 26864.6 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#2] jquery.html Cycles:180 Average:40733.47 Median:12811.39 stddev:103419.45 (807.2%) stddev-sans-first:103665.65 19:16:21 INFO - PID 31942 | Values: 595.5 603.6 609.4 610.9 627.4 23270.5 23897.2 23923.8 23930.4 25036.6 25845.0 26884.3 26960.9 27051.9 27080.5 6334.0 6380.5 6430.8 6464.7 6466.1 4372.7 4570.6 6304.6 6529.0 6567.9 6508.6 6522.9 6524.8 6528.8 6529.4 6517.3 6530.8 6530.9 6531.9 6537.9 6086.5 6097.3 6097.5 6103.3 6109.6 30752.2 30947.0 30967.2 32153.5 32322.7 2297.4 2352.2 2363.3 2365.0 2365.2 19474.6 19749.6 19831.9 19901.8 20051.2 2431.1 2458.9 2480.1 2483.1 2506.6 148117.3 151437.0 164063.0 169577.2 170511.0 15546.3 16187.4 16607.3 16892.7 16955.2 25337.0 25372.0 25385.0 25423.6 25431.4 11253.8 11358.1 11444.1 11597.6 11668.8 9633.2 10595.7 10720.3 10815.2 10855.7 8640.6 9558.3 9636.0 9773.7 9800.8 2815.2 2964.2 3000.8 3011.8 3099.0 1074.8 1086.2 1087.0 1096.9 1111.9 21554.8 21603.1 21608.7 21853.8 22108.9 1140.0 1140.3 1161.8 1175.1 1179.9 11523.8 12018.6 12116.6 12180.4 12267.6 595544.0 605749.0 614616.0 624844.0 641666.0 130827.3 131552.3 132293.3 132337.3 132611.0 1287.2 1301.2 1323.0 1332.5 1343.9 18795.2 18933.2 18999.9 19385.7 19654.8 66792.7 66799.3 67591.0 68115.3 69690.0 80146.0 80472.0 81025.6 81067.2 81091.0 14996.4 15929.8 16118.4 16148.3 16222.7 24139.3 24914.4 25250.4 25255.9 25256.9 20455.2 20564.7 20584.4 20622.4 20706.3 18447.5 18533.2 18575.5 18803.1 19097.3 20682.0 21000.7 21190.0 21327.0 21366.0 15601.8 15796.5 15901.0 15955.0 16024.8 19671.6 20132.1 20191.9 20383.6 20453.9 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#3] mootools.html Cycles:180 Average:10384.24 Median:24048.70 stddev:7362.41 (30.6%) stddev-sans-first:7352.46 19:16:21 INFO - PID 31942 | Values: 1449.4 1502.0 1522.3 1540.7 1543.4 15806.8 16340.3 16348.7 16403.4 16754.3 16984.9 17276.4 17276.7 17286.1 17294.0 2948.6 2983.8 3032.8 3035.6 3043.1 2929.5 2982.9 3056.8 3057.3 3057.6 2993.3 3010.4 3041.4 3059.1 3060.4 2971.4 2997.8 3018.9 3027.0 3027.7 2849.0 2902.8 2903.1 2960.6 2978.8 15978.7 16075.5 16105.0 16110.8 16132.6 8612.4 8823.0 8865.0 8890.6 8920.8 5761.4 5774.0 6010.6 6061.8 6069.9 1980.2 2046.9 2059.2 2068.3 2103.2 28685.3 28965.3 28967.4 28975.0 28985.3 7413.5 7448.3 7591.7 7695.3 7786.8 18978.2 19061.4 19118.1 19146.9 19149.0 8261.0 8668.5 8680.3 8688.4 8701.2 7902.4 7975.6 8022.5 8192.8 8198.8 5545.2 5673.3 5702.2 5839.8 5987.1 1759.4 1768.8 1777.3 1778.3 1814.4 970.1 981.4 982.5 988.0 1012.5 9104.4 9355.0 9441.4 9570.5 9678.3 1073.4 1075.5 1085.3 1090.5 1091.3 5335.4 5727.2 6008.3 6085.9 6087.9 23185.4 23514.4 23515.2 24671.8 24702.0 23574.8 23739.9 23809.2 23952.0 24145.4 12552.5 12615.9 12860.4 13043.5 13048.7 9493.2 9977.5 10010.5 10083.3 10165.1 20721.3 20847.2 20887.0 21142.0 21231.6 21385.0 21452.8 21544.5 21582.0 21754.7 13595.8 13664.6 13886.3 13894.1 13901.9 13591.2 14150.4 15011.2 15129.1 15402.5 12279.7 12347.8 12412.3 12569.6 12759.9 11823.4 11940.5 11968.8 12010.9 12066.3 11252.5 11336.5 11368.8 11379.7 11390.4 7966.1 8223.5 8238.6 8248.1 8278.8 8125.4 8213.6 8333.9 8411.6 8422.6 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#4] prototype.html Cycles:180 Average:5807.68 Median:6345.65 stddev:1588.07 (25.0%) stddev-sans-first:1542.43 19:16:21 INFO - PID 31942 | Values: 534.8 540.9 565.3 570.2 572.9 6270.3 6292.7 6312.3 6352.5 6372.9 6086.0 6174.2 6237.9 6272.8 6301.7 4922.6 4932.1 4942.3 4959.7 4970.9 4846.8 4978.4 4983.4 4994.1 4997.6 5024.8 5036.4 5054.6 5133.8 5153.6 5034.3 5054.4 5056.2 5066.1 5095.2 4752.9 4773.7 4786.5 4858.2 4863.0 6241.2 6250.0 6279.5 6282.8 6284.3 6178.4 6234.7 6265.6 6275.4 6307.6 6739.0 6765.8 6800.9 6847.9 6851.8 5443.0 5487.5 5492.7 5497.0 5504.8 7038.9 7089.3 7090.3 7103.5 7112.8 5674.0 5679.1 5709.3 5751.2 5758.1 5803.1 5807.5 5839.8 5842.6 5860.4 6095.2 6215.4 6230.8 6235.3 6311.4 6659.9 6707.1 6716.9 6803.5 6833.3 1920.0 1934.5 1939.7 1993.9 2029.8 1483.2 1494.3 1506.8 1507.9 1524.8 6338.8 6354.3 6384.9 6386.4 6441.4 6688.4 6762.8 6872.0 6881.3 6927.2 6224.5 6293.0 6402.8 6417.8 6445.4 3618.4 3630.2 3639.9 3681.9 3728.7 7073.7 7091.6 7192.4 7194.5 7209.3 7042.0 7046.8 7085.3 7114.1 7172.4 7175.7 7181.5 7199.9 7212.7 7221.6 6841.1 6859.8 6944.7 6960.1 6987.5 6773.6 6785.4 6814.3 6865.6 6885.8 7093.4 7113.6 7142.8 7182.6 7227.7 5282.4 5292.4 5311.3 5344.7 5350.8 6676.8 6811.7 6845.4 6921.0 6924.7 6456.3 6586.6 6613.7 6703.0 6786.3 6733.9 6752.0 6762.9 6764.0 6769.6 6693.8 6697.1 6705.5 6747.4 6756.2 6795.4 6820.8 6836.1 6852.6 6868.8 6531.7 6592.1 6592.9 6662.0 6666.2 19:16:21 INFO - PID 31942 | 19:16:21 INFO - PID 31942 | [#5] yui.html Cycles:180 Average:26127.44 Median:17780.64 stddev:37407.79 (210.4%) stddev-sans-first:37464.93 19:16:21 INFO - PID 31942 | Values: 941.2 965.8 977.1 982.8 1001.2 19243.2 20071.9 20177.9 20197.1 22172.4 21698.1 21918.3 22138.3 22179.9 22340.8 1060.9 1084.4 1087.1 1087.4 1089.3 1083.1 1094.6 1096.7 1096.9 1098.4 1016.5 1086.8 1090.2 1090.8 1092.7 1074.1 1075.5 1080.1 1081.2 1081.7 795.3 800.3 801.1 802.1 803.8 20274.8 20789.2 20922.0 21007.8 21094.9 18943.1 19538.0 21288.1 21832.8 21832.9 17492.9 17571.0 17631.3 17705.3 17756.3 3832.4 3856.3 3856.5 3856.7 3858.2 141475.3 142368.3 143837.3 145015.0 147156.0 16506.3 16979.3 17049.7 17051.3 17059.0 30880.7 31889.5 32104.8 32121.4 32134.4 9036.9 9056.1 9067.7 9149.5 9159.7 4528.9 4597.8 4650.0 4667.1 4669.2 5649.3 5749.7 6213.1 6503.7 6505.6 1261.6 1277.5 1290.5 1291.7 1294.1 771.8 782.9 788.3 791.9 792.1 13140.2 13906.4 14045.3 15511.8 15539.8 780.9 796.1 797.2 801.2 813.4 6412.8 6448.4 6780.9 6807.1 6813.7 127417.0 129870.0 130586.0 133718.0 134135.0 115946.0 116526.4 117870.4 118417.4 123279.4 97050.5 99705.5 103223.0 104221.5 106757.5 12155.5 12250.3 12295.3 12360.7 12430.3 46163.8 46894.0 47699.0 47752.0 47956.3 62686.0 63257.0 63400.4 63937.7 66152.7 17003.6 17349.8 17412.8 17432.2 17526.1 18772.7 18946.4 19130.6 19260.1 19430.7 17758.7 17760.9 17800.4 17832.1 18026.6 16890.7 16908.2 16989.5 17015.9 17050.2 16390.5 16410.1 16514.8 16559.8 16567.3 12663.6 13134.7 13466.3 13569.3 13603.5 15912.4 15942.5 16340.8 16451.6 16831.7 19:16:21 INFO - PID 31942 | -------- Summary: end -------- 19:16:21 INFO - PID 31942 | 19:16:22 INFO - TEST-INFO | 31942: exit 0 19:16:22 INFO - TEST-OK | dromaeo_css | took 1109177ms 19:16:22 INFO - TEST-START | kraken 19:16:22 INFO - Initialising browser for kraken test... 19:16:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44230/getInfo.html -profile /tmp/tmpsyWXrU/profile 19:16:22 INFO - TEST-INFO | started process 32301 (/builds/slave/test/build/application/firefox/firefox http://localhost:44230/getInfo.html) 19:16:28 INFO - TEST-INFO | 32301: exit 0 19:16:28 INFO - Browser initialized. 19:16:28 INFO - Running cycle 1/1 for kraken test... 19:16:28 INFO - TEST-INFO | started process 32460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyWXrU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:16:28 INFO - PID 32460 | 1504145788444 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 19:16:39 INFO - PID 32460 | RSS: Main: 151785472 19:16:39 INFO - PID 32460 | 19:16:41 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-beat-detection) 19:16:42 INFO - PID 32460 | RSS: Main: 157597696 19:16:42 INFO - PID 32460 | 19:16:45 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-dft) 19:16:45 INFO - PID 32460 | RSS: Main: 157818880 19:16:45 INFO - PID 32460 | 19:16:48 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-fft) 19:16:49 INFO - PID 32460 | RSS: Main: 158752768 19:16:49 INFO - PID 32460 | 19:16:51 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-oscillator) 19:16:52 INFO - PID 32460 | RSS: Main: 159199232 19:16:52 INFO - PID 32460 | 19:16:54 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:54 INFO - PID 32460 | RSS: Main: 158609408 19:16:54 INFO - PID 32460 | 19:16:57 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:58 INFO - PID 32460 | RSS: Main: 158576640 19:16:58 INFO - PID 32460 | 19:17:01 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:02 INFO - PID 32460 | RSS: Main: 161853440 19:17:02 INFO - PID 32460 | 19:17:05 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44230/tests/kraken/driver.html?testName=json-parse-financial) 19:17:05 INFO - PID 32460 | RSS: Main: 162504704 19:17:05 INFO - PID 32460 | 19:17:07 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:07 INFO - PID 32460 | RSS: Main: 162185216 19:17:07 INFO - PID 32460 | 19:17:09 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:10 INFO - PID 32460 | RSS: Main: 162123776 19:17:10 INFO - PID 32460 | 19:17:12 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:12 INFO - PID 32460 | RSS: Main: 161894400 19:17:12 INFO - PID 32460 | 19:17:15 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:17:16 INFO - PID 32460 | RSS: Main: 162144256 19:17:16 INFO - PID 32460 | 19:17:18 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:19 INFO - PID 32460 | RSS: Main: 162603008 19:17:19 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44230/tests/kraken/driver.html?testName=ai-astar) 19:17:21 INFO - PID 32460 | RSS: Main: 164581376 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | __start_tp_report 19:17:21 INFO - PID 32460 | _x_x_mozilla_page_load 19:17:21 INFO - PID 32460 | _x_x_mozilla_page_load_details 19:17:21 INFO - PID 32460 | |i|pagename|runs| 19:17:21 INFO - PID 32460 | |0;ai-astar;95;110;101;105;105;107;106;104;106;106 19:17:21 INFO - PID 32460 | |1;audio-beat-detection;144;114;151;156;113;135;140;117;163;118 19:17:21 INFO - PID 32460 | |2;audio-dft;162;164;161;161;161;162;161;161;162;162 19:17:21 INFO - PID 32460 | |3;audio-fft;75;75;76;175;75;74;77;74;157;77 19:17:21 INFO - PID 32460 | |4;audio-oscillator;78;77;130;77;78;77;126;77;76;128 19:17:21 INFO - PID 32460 | |5;imaging-gaussian-blur;113;114;114;114;113;114;115;113;113;114 19:17:21 INFO - PID 32460 | |6;imaging-darkroom;148;148;150;147;148;147;147;149;151;147 19:17:21 INFO - PID 32460 | |7;imaging-desaturate;93;94;96;94;94;94;94;95;99;94 19:17:21 INFO - PID 32460 | |8;json-parse-financial;46;49;47;46;46;51;51;45;46;45 19:17:21 INFO - PID 32460 | |9;json-stringify-tinderbox;54;53;53;53;54;54;54;53;53;54 19:17:21 INFO - PID 32460 | |10;stanford-crypto-aes;74;73;74;74;73;73;72;77;75;74 19:17:21 INFO - PID 32460 | |11;stanford-crypto-ccm;128;122;131;112;121;118;119;116;116;157 19:17:21 INFO - PID 32460 | |12;stanford-crypto-pbkdf2;159;176;162;168;160;154;159;156;160;161 19:17:21 INFO - PID 32460 | |13;stanford-crypto-sha256-iterative;59;60;59;65;58;58;58;57;59;59 19:17:21 INFO - PID 32460 | __end_tp_report 19:17:21 INFO - PID 32460 | __start_cc_report 19:17:21 INFO - PID 32460 | _x_x_mozilla_cycle_collect,801 19:17:21 INFO - PID 32460 | __end_cc_report 19:17:21 INFO - PID 32460 | __startTimestamp1504145841421__endTimestamp 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | ------- Summary: start ------- 19:17:21 INFO - PID 32460 | Number of tests: 14 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#0] ai-astar Cycles:10 Average:104.50 Median:106.00 stddev:4.03 (3.8%) stddev-sans-first:2.40 19:17:21 INFO - PID 32460 | Values: 95.0 110.0 101.0 105.0 105.0 107.0 106.0 104.0 106.0 106.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:142.00 stddev:18.63 (13.1%) stddev-sans-first:19.48 19:17:21 INFO - PID 32460 | Values: 144.0 114.0 151.0 156.0 113.0 135.0 140.0 117.0 163.0 118.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 19:17:21 INFO - PID 32460 | Values: 162.0 164.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 162.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:38.46 (51.3%) stddev-sans-first:40.21 19:17:21 INFO - PID 32460 | Values: 75.0 75.0 76.0 175.0 75.0 74.0 77.0 74.0 157.0 77.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:77.00 stddev:24.59 (31.9%) stddev-sans-first:25.52 19:17:21 INFO - PID 32460 | Values: 78.0 77.0 130.0 77.0 78.0 77.0 126.0 77.0 76.0 128.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:17:21 INFO - PID 32460 | Values: 113.0 114.0 114.0 114.0 113.0 114.0 115.0 113.0 113.0 114.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 19:17:21 INFO - PID 32460 | Values: 148.0 148.0 150.0 147.0 148.0 147.0 147.0 149.0 151.0 147.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.70 (1.8%) stddev-sans-first:1.69 19:17:21 INFO - PID 32460 | Values: 93.0 94.0 96.0 94.0 94.0 94.0 94.0 95.0 99.0 94.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#8] json-parse-financial Cycles:10 Average:47.20 Median:46.50 stddev:2.30 (4.9%) stddev-sans-first:2.40 19:17:21 INFO - PID 32460 | Values: 46.0 49.0 47.0 46.0 46.0 51.0 51.0 45.0 46.0 45.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 19:17:21 INFO - PID 32460 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 54.0 53.0 53.0 54.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:1.37 (1.9%) stddev-sans-first:1.45 19:17:21 INFO - PID 32460 | Values: 74.0 73.0 74.0 74.0 73.0 73.0 72.0 77.0 75.0 74.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:121.50 stddev:12.91 (10.6%) stddev-sans-first:13.61 19:17:21 INFO - PID 32460 | Values: 128.0 122.0 131.0 112.0 121.0 118.0 119.0 116.0 116.0 157.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:160.50 stddev:6.29 (3.9%) stddev-sans-first:6.61 19:17:21 INFO - PID 32460 | Values: 159.0 176.0 162.0 168.0 160.0 154.0 159.0 156.0 160.0 161.0 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.00 stddev:2.20 (3.7%) stddev-sans-first:2.33 19:17:21 INFO - PID 32460 | Values: 59.0 60.0 59.0 65.0 58.0 58.0 58.0 57.0 59.0 59.0 19:17:21 INFO - PID 32460 | -------- Summary: end -------- 19:17:21 INFO - PID 32460 | 19:17:21 INFO - PID 32460 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:17:22 INFO - TEST-INFO | 32460: exit 0 19:17:22 INFO - TEST-OK | kraken | took 59857ms 19:17:22 INFO - SUITE-END | took 1169s 19:17:22 INFO - Completed test suite (00:19:29) 19:17:22 INFO - javascript benchmark 19:17:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9158.05915079228, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3544.5214895989034, 3582.8387722552484, 3589.910252243694, 3599.532060832092, 3655.5796083450396, 6376.458001069915, 6403.0, 6438.388353106459, 6470.450011748995, 6480.12518310028, 6422.710978005989, 6451.096846441502, 6508.991106378507, 6514.967425162879, 6517.902231466532, 5458.972705136489, 5568.582356323272, 5574.721263936807, 5612.382637909826, 5648.237487939137, 5655.547556195515, 5671.8014869479575, 5676.091825307952, 5687.886242275152, 5698.6865722385255, 5616.466435688623, 5649.548036157118, 5693.544516438696, 5711.0, 5715.771369145229, 5535.750891209906, 5565.972170139124, 5595.916061259084, 5664.26364572603, 5665.093585026417, 5589.077802162638, 5592.217089607459, 5631.324241091054, 5645.971770141164, 5646.802361917313, 6278.87442251157, 6311.242650881878, 6391.680415979183, 6414.93585064148, 6431.5819471734185, 6827.21487028993, 6917.827054323682, 6951.930480695179, 6966.512344135913, 7055.047568578228, 6962.512624116314, 7066.752663656747, 7082.008518807371, 7083.114610673666, 7095.8226044348785, 6499.642519661416, 6515.576487528296, 6539.901901471481, 6604.50466215031, 6605.9669701651665, 7062.6821793019435, 7153.284671532805, 7165.176004759519, 7172.605506697182, 7178.318059784312, 6779.593224406552, 6825.522213445011, 6826.863462730717, 6859.759908403182, 6882.655867206719, 6979.825504362431, 7009.684564194521, 7088.149422069385, 7099.219085900547, 7118.679659415338, 6952.548084374601, 6970.895436568456, 6975.162980442379, 7049.295070493013, 7053.188883278386, 6900.447964162955, 6963.1296087989, 6975.058367120374, 6975.6163411012885, 7064.116985376828, 5124.256982737482, 5139.665921715076, 5151.0470562945975, 5151.943851510431, 5153.793848246103, 4577.793999270041, 4581.65637577183, 4611.723296602215, 4630.6063984561015, 4658.114958157939, 6476.5466417350335, 6602.108715323466, 6609.5373323867825, 6678.933210667831, 6679.532432729759, 6992.965035174791, 6999.8600027999155, 7042.084529011196, 7060.717571297193, 7074.71701131949, 6531.836704082436, 6593.967030164818, 6600.372964568358, 6616.801495955129, 6629.872921603339, 5796.710164491758, 5821.476067153976, 5893.02765043763, 5898.498627616615, 5902.557308201902, 7016.36852683261, 7160.677769500385, 7174.0315057467615, 7208.675609597581, 7257.92742072583, 6990.790276291719, 7032.718691252293, 7054.894176587252, 7067.6112813795735, 7068.787936361918, 7209.6395180241825, 7214.422846172189, 7216.855662886818, 7285.23505031964, 7300.415966722756, 6770.966145169243, 6856.24581296067, 6870.965645171742, 6897.137857767779, 6972.163340399185, 7057.36483716468, 7063.328983746535, 7072.611006394698, 7087.433005359662, 7090.539114957512, 6791.219009813737, 6801.149856267966, 6814.250432452525, 6855.0, 6870.3473170048765, 6690.565113267622, 6752.3922846944015, 6766.830829229112, 6768.864622707617, 6786.423154031962, 6747.460203183831, 6753.425958793361, 6759.0, 6766.2218844831505, 6770.1537307836525, 6784.830379240559, 6787.864242715019, 6817.659117044029, 6868.862622747617, 6913.0, 6651.63416012124, 6684.565503242274, 6742.9662851685425, 6746.224184218878, 6758.222804377363], "value": 6354.034564977517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.4478450968143, 917.3074328881689, 947.9146876781091, 976.6093562574969, 976.7606936300607, 40817.3877391839, 42193.789031054876, 42355.0, 42355.36466952998, 42479.57520424795, 40460.190796184055, 40550.18899622006, 40605.59394406055, 40784.99999999993, 40849.59150408502, 7099.432045436352, 7163.212046674862, 7169.85660286794, 7201.67592458338, 7222.061132052826, 7048.647567621624, 7143.3570978611915, 7143.499955003152, 7146.106736657918, 7158.105236845395, 7101.8224544386285, 7691.884621730678, 7809.648565814552, 7860.960695196516, 7903.604819759018, 7754.8449031019345, 7827.843443131134, 7859.528428294292, 7862.056553213593, 7862.135165131831, 7696.268854458874, 7738.0, 7738.651760670783, 7791.376689864797, 7796.0, 40851.38722919158, 40940.590594094276, 41011.0, 41013.384799228035, 41244.38133428001, 3670.871519496805, 3681.9447708284397, 3713.3316003119426, 3716.6469185427613, 3718.1634132320282, 32776.5083523745, 33052.1736956578, 33073.66926330754, 33101.17247068819, 33171.0, 5122.129238029506, 5171.844844654666, 5200.583953283766, 5222.791088356461, 5235.502627250406, 207597.0, 207977.0, 213760.0, 218232.0, 231652.84173579194, 52715.73642131841, 53064.204036939474, 53082.73458632759, 53096.734516327946, 53127.0, 55088.44911550913, 55177.448225518034, 55204.447955520736, 55265.0, 55281.1707824383, 16847.241874115694, 17014.659706805796, 17079.743803842954, 17146.82853171477, 17282.22229999628, 14068.226247556278, 14159.221242831743, 14173.858261417254, 14180.078294910798, 14180.432782688784, 14941.925290373478, 15038.248087595577, 15055.0, 15097.0, 15375.0, 5978.4021597839865, 6064.969675151596, 6065.5754097212775, 6130.938690613126, 6189.597676151036, 1092.229977865603, 1102.3496137279044, 1103.3986477369854, 1105.132471010253, 1128.0637071230858, 24877.378065548506, 24994.750052499243, 25111.62332565013, 25233.495330093294, 25274.115405960703, 1205.5358686905429, 1218.366449446283, 1226.625879106863, 1227.9508819647115, 1228.791105512065, 13139.42875951933, 13273.269970151541, 13452.596422107352, 13454.260015699036, 13550.59348219555, 256402.0, 268285.0, 269754.0, 269895.0, 270308.0, 55970.16044759332, 56016.159757603666, 56108.43891561032, 56506.0, 56542.717286414125, 1517.9620509487352, 1550.3411050303575, 1567.686462707463, 1572.4024870549347, 1593.8326475719882, 24471.143509977777, 25000.249862575147, 25045.499090017733, 25098.749012510372, 25412.491750164525, 41078.58921410747, 41089.0, 41157.794211028755, 41189.382159267036, 41191.588084118775, 222594.0, 223957.0, 223977.0, 224557.0, 224711.0, 35819.82090089533, 35971.28057438889, 37100.81449592735, 37501.0, 37685.623143768215, 47258.291125633834, 47494.52505474901, 48103.75948120237, 48117.27824082572, 48786.0, 35316.293674126886, 35552.822235888656, 36050.819745901106, 36081.45877811783, 36141.0, 36033.63966360407, 36057.098572534844, 36114.8194259027, 36333.0916727084, 36687.0, 41000.179996400504, 41756.0, 41868.0, 42757.0, 42916.35625465683, 34484.48273275853, 34630.480542792386, 34845.12887177739, 35050.82474587611, 35065.47401788924, 25892.870535647202, 26429.0, 26464.470710586065, 26696.0, 26864.59703104494], "value": 18342.197409376375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5235811350921, 603.5563860562486, 609.4027852704347, 610.9266887973442, 627.3506920337451, 23270.534589308223, 23897.16359927403, 23923.760762392372, 23930.40173995651, 25036.624450633208, 25845.0, 26884.327891802666, 26960.865195674043, 27051.86474067632, 27080.458390832173, 6334.049892516125, 6380.457661098812, 6430.839229019265, 6464.676766161697, 6466.094746735461, 4372.672049596277, 4570.611498022672, 6304.62172269663, 6529.0, 6567.868642627144, 6508.576942498722, 6522.902156467657, 6524.836879078037, 6528.7714929977465, 6529.379708927644, 6517.3482651734685, 6530.836729081787, 6530.869382612369, 6531.8693626127215, 6537.869242615168, 6086.543509236825, 6097.298810636789, 6097.512199024068, 6103.328633850273, 6109.633421994695, 30752.2311942201, 30947.0, 30967.22581935447, 32153.51769723456, 32322.6767732322, 2297.3911913342977, 2352.235523454884, 2363.255574494046, 2365.0066971871856, 2365.219477572397, 19474.610507789766, 19749.605007899907, 19831.900840495848, 19901.800981990138, 20051.1979520819, 2431.149097815768, 2458.8524688518746, 2480.1071614218868, 2483.056438553356, 2506.624006399055, 148117.25941370224, 151437.0, 164063.0, 169577.15211423987, 170511.0, 15546.300416481285, 16187.433439829785, 16607.3357065716, 16892.662146756997, 16955.237014334383, 25337.0, 25372.0, 25385.0, 25423.61864572033, 25431.36421589438, 11253.831192532118, 11358.091352691765, 11444.084473242121, 11597.594084207012, 11668.824967625493, 9633.229341652652, 10595.682129536126, 10720.303180293411, 10815.188860835311, 10855.728606784736, 8640.567971601395, 9558.330916835755, 9635.951820240994, 9773.706788796348, 9800.803983920281, 2815.211740712604, 2964.24411774996, 3000.819950802959, 3011.8192908425563, 3099.0, 1074.80696426966, 1086.1745073743853, 1087.0434018064052, 1096.8519249901321, 1111.9499622517005, 21554.784452155593, 21603.135874565156, 21608.675869861963, 21853.781462185492, 22108.88945555262, 1139.9886001140048, 1140.321508702321, 1161.8083016302385, 1175.0951767139254, 1179.887910648487, 11523.827142592867, 12018.639440816789, 12116.636500904988, 12180.390980450942, 12267.57063502773, 595544.0, 605749.0, 614616.0, 624844.0, 641666.0, 130827.34586327008, 131552.34223829012, 132293.33853330673, 132337.33831330782, 132611.0, 1287.2019348004296, 1301.2387753164317, 1322.9933850330879, 1332.5469340424302, 1343.9126456780277, 18795.248190072245, 18933.242670293585, 18999.905000474908, 19385.709214361515, 19654.80345196587, 66792.6660366695, 66799.33200668126, 67591.0, 68115.31884681288, 69690.0, 80146.0, 80472.0, 81025.59487202526, 81067.18932810596, 81091.0, 14996.400143994555, 15929.761053583974, 16118.355265789705, 16148.273327700517, 16222.67554648924, 24139.275821725376, 24914.377140571632, 25250.36874078163, 25255.87372063128, 25256.873715631304, 20455.181792728123, 20564.691529627366, 20584.382468525968, 20622.38132856017, 20706.275280365717, 18447.53881152982, 18533.166007529962, 18575.535611609277, 18803.05984700787, 19097.331593394163, 20681.965901704552, 21000.68498972486, 21190.0, 21327.0, 21366.0, 15601.765973510179, 15796.526104216891, 15901.0, 15955.0, 16024.759628605347, 19671.60656786885, 20132.094055767233, 20191.899040504704, 20383.59232815365, 20453.897730511253], "value": 12973.518255761452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.3984996226566, 1502.038695235049, 1522.345391481664, 1540.6995635851006, 1543.398074750848, 15806.84193158068, 16340.346386144554, 16348.673026539462, 16403.425880094168, 16754.329826806945, 16984.915075424604, 17276.395326163587, 17276.654466910655, 17286.13569321532, 17294.04882731449, 2948.631421072366, 2983.791134620572, 3032.8331941743195, 3035.575019497272, 3043.087073877839, 2929.4580502606977, 2982.925426864335, 3056.8013079149896, 3057.327387974642, 3057.5719399284117, 2993.311538346182, 3010.3678227572236, 3041.406925649499, 3059.082275317407, 3060.4338197433435, 2971.435427268823, 2997.8351190684502, 3018.894338698146, 3027.0, 3027.7275045246033, 2849.0313293480317, 2902.782291328138, 2903.056506635331, 2960.585518027478, 2978.8361640109783, 15978.680426391407, 16075.517734467985, 16105.0, 16110.83889161105, 16132.59668508285, 8612.440191387539, 8822.985356684, 8865.0, 8890.644374225023, 8920.821583568357, 5761.423857614247, 5773.971130144322, 6010.639361638316, 6061.818145455643, 6069.878602427971, 1980.2178139634907, 2046.8505779167099, 2059.1969132038516, 2068.338131797825, 2103.2112957640884, 28685.28286792826, 28965.275868103254, 28967.42065158706, 28975.0, 28985.275368115967, 7413.481056326005, 7448.255174482509, 7591.696332146652, 7695.268949449794, 7786.844263114706, 18978.24087036503, 19061.428157155307, 19118.139683714267, 19146.904265478584, 19149.0, 8261.0, 8668.479891206547, 8680.34897382699, 8688.435251708619, 8701.17338852808, 7902.3678105751405, 7975.60121993898, 8022.5186488809695, 8192.795180120545, 8198.795030124294, 5545.195946587723, 5673.262475878109, 5702.201691763156, 5839.824805255849, 5987.072003839412, 1759.366628013914, 1768.823117688221, 1777.2624360890086, 1778.2975724588973, 1814.4375243674504, 970.1414248390084, 981.3719219699398, 982.5332966840837, 987.9506024698736, 1012.4988130875116, 9104.362694611315, 9354.953225233967, 9441.386309889835, 9570.473623950611, 9678.274129440179, 1073.3613499967507, 1075.5267682219799, 1085.3054045410943, 1090.5201711247025, 1091.2633972068822, 5335.439778823167, 5727.2268243787385, 6008.3390827009, 6085.908711369333, 6087.873743357493, 23185.420364491023, 23514.412139696644, 23515.17696880601, 24671.753282466947, 24702.0, 23574.7642523576, 23739.881300593388, 23809.166679166145, 23952.0, 24145.396365091012, 12552.497900083894, 12615.936920315524, 12860.421281042376, 13043.543475978295, 13048.673783155496, 9493.24054075686, 9977.45124018186, 10010.549525271235, 10083.294169408071, 10165.085142337226, 20721.274755384093, 20847.166113355903, 20887.0, 21142.0, 21231.575368492235, 21385.03767330443, 21452.78547214508, 21544.461388464788, 21582.0, 21754.6736798945, 13595.796063058864, 13664.590062298146, 13886.305684715522, 13894.096883702527, 13901.86098139046, 13591.184528928296, 14150.363233654305, 15011.174385408907, 15129.092254464767, 15402.46091386841, 12279.666863295944, 12347.814782778445, 12412.255264684149, 12569.560065397667, 12759.87240127624, 11823.408829558659, 11940.46267917963, 11968.820467692818, 12010.939945300217, 12066.336351500751, 11252.549898004316, 11336.489857956576, 11368.829467558158, 11379.715507112389, 11390.430478476208, 7966.123726389977, 8223.506589604644, 8238.629261683358, 8248.13394593583, 8278.751637450887, 8125.3905957052275, 8213.630386632496, 8333.916660833556, 8411.621477033426, 8422.578871056545], "value": 7440.271855765574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.7807398966424, 540.9432009638989, 565.3244372974298, 570.2017175953665, 572.8940146072974, 6270.341614130519, 6292.653904035276, 6312.274088479815, 6352.5235607329405, 6372.904406433907, 6086.0, 6174.228221472316, 6237.875242495147, 6272.811815645527, 6301.6849157542165, 4922.581580565657, 4932.112219800426, 4942.258661200831, 4959.6528243023, 4970.900581988376, 4846.830360937368, 4978.352814134176, 4983.401991760976, 4994.101061808873, 4997.550220480156, 5024.763980028889, 5036.370453693288, 5054.570361519275, 5133.845984620468, 5153.577818425334, 5034.3363715819705, 5054.4440111588065, 5056.2162864755655, 5066.06277838601, 5095.210242412432, 4752.881177970544, 4773.68229080789, 4786.52134786522, 4858.222684370519, 4862.975685121552, 6241.21984751906, 6249.96875515544, 6279.497640188774, 6282.811515654537, 6284.27730810958, 6178.38216178383, 6234.719437625273, 6265.592736472115, 6275.372462753734, 6307.558470907038, 6739.0, 6765.75243882939, 6800.931990680129, 6847.863042739117, 6851.828704282383, 5443.0, 5487.533559647435, 5492.725363731837, 5496.972515137439, 5504.7522861470925, 7038.929610703879, 7089.2556281590205, 7090.298328401198, 7103.549275499944, 7112.751053713147, 5674.0, 5679.109809780231, 5709.25779648643, 5751.166080918243, 5758.0787074068785, 5803.100519419412, 5807.506361959281, 5839.766409343579, 5842.620229685057, 5860.443257890493, 6095.207623009069, 6215.378462153749, 6230.7507699691505, 6235.251769787655, 6311.431971122529, 6659.866802664016, 6707.128073350531, 6716.865662686719, 6803.523753337219, 6833.3166683331265, 1919.9904000479908, 1934.516370907273, 1939.6799528077709, 1993.920243190256, 2029.786872378379, 1483.1546018769413, 1494.267808773693, 1506.7815166800972, 1507.8567536084054, 1524.801775769143, 6338.778142765073, 6354.269259035178, 6384.936150638527, 6386.425221730066, 6441.355864413521, 6688.431483323875, 6762.830929226809, 6872.0, 6881.311868813179, 6927.203371612329, 6224.502039836802, 6292.96166132583, 6402.775902843378, 6417.7753778617525, 6445.4199122079235, 3618.3667858124722, 3630.2376500935097, 3639.9272014560092, 3681.9263614727556, 3728.7389882708494, 7073.726729188693, 7091.574505529685, 7192.352688258082, 7194.532355396883, 7209.315115064165, 7041.957832228596, 7046.753363632351, 7085.32689394517, 7114.146302443636, 7172.390346820474, 7175.712971481186, 7181.461390395742, 7199.892001619875, 7212.6919385796045, 7221.638918054076, 6841.076454678555, 6859.794206173823, 6944.687489062903, 6960.095187625576, 6987.545809522569, 6773.593584384756, 6785.423239024738, 6814.284500127415, 6865.588064716133, 6885.827854303682, 7093.361597456254, 7113.57318560888, 7142.821429464305, 7182.640867956686, 7227.747028853965, 5282.392524859537, 5292.391374991926, 5311.309529761106, 5344.732763361894, 5350.839474815762, 6676.799696008933, 6811.659417029228, 6845.418139458202, 6920.9653951729915, 6924.6537673117155, 6456.257530384066, 6586.595892499299, 6613.702383392662, 6703.0, 6786.253512113763, 6733.898991515229, 6752.0, 6762.8985565217545, 6763.951587503748, 6769.593824370553, 6693.832654183684, 6697.09589205451, 6705.530612857053, 6747.359000894907, 6756.189257289157, 6795.354441328066, 6820.829479263058, 6836.111305530249, 6852.554583952027, 6868.793936181923, 6531.706073226621, 6592.143021407378, 6592.868142637216, 6661.966690166712, 6666.2333831609985], "value": 5357.834411602739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [941.2328951904198, 965.7778710896492, 977.062020460358, 982.83783175776, 1001.2340559472003, 19243.23027078917, 20071.899640501797, 20177.899110504426, 20197.09113089911, 22172.445688857788, 21698.132074717032, 21918.342449726533, 22138.33584992453, 22179.889100554476, 22340.776592234073, 1060.8620879285681, 1084.3927400655618, 1087.0542627913726, 1087.3910610058354, 1089.2974031749516, 1083.1226706367827, 1094.5621751299504, 1096.6655170173094, 1096.9341839489616, 1098.4233277529322, 1016.4917541229386, 1086.7717779266363, 1090.2477290669412, 1090.798202332571, 1092.743205346747, 1074.1031238915516, 1075.5321435175686, 1080.1466841195447, 1081.2431298091328, 1081.6646839479786, 795.2762985683, 800.2837460472903, 801.1427772283658, 802.0535767794, 803.8392321535716, 20274.797252027438, 20789.16843326265, 20922.0, 21007.789922100736, 21094.894525527427, 18943.147558359906, 19538.0, 21288.148474061174, 21832.781672183235, 21832.89083554572, 17492.91253543724, 17571.0, 17631.294748210057, 17705.29178832845, 17756.289748410047, 3832.367659336206, 3856.3058649443087, 3856.4986551748375, 3856.7107466940092, 3858.1704933439164, 141475.29262353622, 142368.2881585596, 143837.28081359525, 145015.0, 147156.0, 16506.33974641025, 16979.320827167023, 17049.7442538362, 17051.31794728222, 17059.0, 30880.691193087783, 31889.521657175163, 32104.83947580247, 32121.357572848414, 32134.35731285361, 9036.8644470333, 9056.13966673165, 9067.68263110788, 9149.451032938045, 9159.679411220575, 4528.864134075983, 4597.839075632337, 4649.953500464952, 4667.113248482845, 4669.229577119805, 5649.322081350264, 5749.741261643236, 6213.068039794067, 6503.674816259168, 6505.577137486048, 1261.6215135459327, 1277.4698500122345, 1290.5160564788205, 1291.728736965229, 1294.1070661243712, 771.8224808294011, 782.8864814601851, 788.2826627768703, 791.8733002719537, 792.0811858244409, 13140.2115873046, 13906.443742250196, 14045.297735113203, 15511.844881551266, 15539.844601554067, 780.8906753054576, 796.0526972902228, 797.1948332184535, 801.2148094867063, 813.4265342933336, 6412.807615771534, 6448.355164483608, 6780.93219067803, 6807.149106361705, 6813.693383797741, 127417.0, 129870.0, 130586.0, 133718.0, 134135.0, 115946.0, 116526.41736791261, 117870.4106479462, 118417.40791295988, 123279.3836030832, 97050.51474742581, 99705.50147249362, 103223.0, 104221.47889260505, 106757.46621267, 12155.513779449077, 12250.326232057323, 12295.32375719344, 12360.690982725144, 12430.264557664013, 46163.76918115388, 46894.0, 47699.0, 47752.0, 47956.280655789495, 62686.0, 63257.0, 63400.365996339446, 63937.680311598146, 66152.67694645983, 17003.574910627332, 17349.826501735326, 17412.82587174163, 17432.215550300014, 17526.123693815513, 18772.7184092236, 18946.43160705181, 19130.617387652448, 19260.133294001524, 19430.708539372205, 17758.733618995466, 17760.91119544394, 17800.3769868054, 17832.10839457996, 18026.63946721032, 16890.74663880018, 16908.15459227009, 16989.49031529056, 17015.914920425814, 17050.232739526502, 16390.508284751475, 16410.097444640658, 16514.83485165133, 16559.751603726196, 16567.254473548477, 12663.556775512812, 13134.671633209246, 13466.326683665973, 13569.321533923461, 13603.455861765815, 15912.443064492687, 15942.521724348288, 16340.754888676442, 16451.58871028234, 16831.7475237874], "value": 9787.214446301652, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 110.0, 101.0, 105.0, 105.0, 107.0, 106.0, 104.0, 106.0, 106.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 151.0, 156.0, 113.0, 135.0, 140.0, 117.0, 163.0, 118.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 175.0, 75.0, 74.0, 77.0, 74.0, 157.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 130.0, 77.0, 78.0, 77.0, 126.0, 77.0, 76.0, 128.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 147.0, 148.0, 147.0, 147.0, 149.0, 151.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 95.0, 99.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 49.0, 47.0, 46.0, 46.0, 51.0, 51.0, 45.0, 46.0, 45.0], "value": 47.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 73.0, 73.0, 72.0, 77.0, 75.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 131.0, 112.0, 121.0, 118.0, 119.0, 116.0, 116.0, 157.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 176.0, 162.0, 168.0, 160.0, 154.0, 159.0, 156.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 65.0, 58.0, 58.0, 58.0, 57.0, 59.0, 59.0], "value": 59.2, "unit": "score"}]}]} 19:17:22 INFO - Return code: 0 19:17:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:17:22 INFO - # TBPL SUCCESS # 19:17:22 INFO - Running post-action listener: _package_coverage_data 19:17:22 INFO - Running post-action listener: _resource_record_post_action 19:17:22 INFO - [mozharness: 2017-08-31 02:17:22.705542Z] Finished run-tests step (success) 19:17:22 INFO - Running post-run listener: _resource_record_post_run 19:17:22 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394022912; Read time: 136; Write time: 272740 19:17:22 INFO - TinderboxPrint: CPU usage
13.0% 19:17:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 136 19:17:22 INFO - TinderboxPrint: I/O write bytes / time
394,022,912 / 272,740 19:17:22 INFO - TinderboxPrint: CPU idle
8,209.5 (86.9%) 19:17:22 INFO - TinderboxPrint: CPU user
1,183.7 (12.5%) 19:17:22 INFO - TinderboxPrint: Swap in / out
0 / 0 19:17:22 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107249664; Read time: 128; Write time: 73084 19:17:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:17:22 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 283369472; Read time: 0; Write time: 199596 19:17:23 INFO - Running post-run listener: _upload_blobber_files 19:17:23 INFO - Blob upload gear active. 19:17:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:17:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:17:23 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:25 INFO - (blobuploader) - INFO - Done attempting. 19:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:17:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:26 INFO - (blobuploader) - INFO - Done attempting. 19:17:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:17:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:17:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:29 INFO - (blobuploader) - INFO - Done attempting. 19:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:17:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:30 INFO - (blobuploader) - INFO - Done attempting. 19:17:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:17:30 INFO - Return code: 0 19:17:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:17:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:17:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0353921391006371b4427c0cb636f5592019f653aa49c5abccdd591ce46899c1a389e8f8abe63a40a6291723e8e71627c82008050a309dfba84669f622be3e76", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f36cc6844beb210db25d64710ded8df549fa280271f48eedb85b9fd99f4d706210bffbc23f304feb5d3d3730e4869e05d5faca6d9e3ddad5851352173523e594", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c2d5a94e720159a5b5c86603d75bf25e89bf55d92b8731c96220954a90828497e4646304bf273e313a32b5fcbc68d371cd956a7a11c2c5a997cb1fb21672f81e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af90db418464b901970a141bb195c1606468fc13de6a39ba19e7bdc746da6314b7358a0ff187134718afcdad2b17f46af270044754cd85f33418fe6342d2019a"} 19:17:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:17:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:17:30 INFO - Contents: 19:17:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0353921391006371b4427c0cb636f5592019f653aa49c5abccdd591ce46899c1a389e8f8abe63a40a6291723e8e71627c82008050a309dfba84669f622be3e76", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f36cc6844beb210db25d64710ded8df549fa280271f48eedb85b9fd99f4d706210bffbc23f304feb5d3d3730e4869e05d5faca6d9e3ddad5851352173523e594", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c2d5a94e720159a5b5c86603d75bf25e89bf55d92b8731c96220954a90828497e4646304bf273e313a32b5fcbc68d371cd956a7a11c2c5a997cb1fb21672f81e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af90db418464b901970a141bb195c1606468fc13de6a39ba19e7bdc746da6314b7358a0ff187134718afcdad2b17f46af270044754cd85f33418fe6342d2019a"} 19:17:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:17:30 INFO - Copying logs to upload dir... 19:17:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:17:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.463299 ========= master_lag: -0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-30 19:17:30.353577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 19:17:30.357393) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0353921391006371b4427c0cb636f5592019f653aa49c5abccdd591ce46899c1a389e8f8abe63a40a6291723e8e71627c82008050a309dfba84669f622be3e76", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f36cc6844beb210db25d64710ded8df549fa280271f48eedb85b9fd99f4d706210bffbc23f304feb5d3d3730e4869e05d5faca6d9e3ddad5851352173523e594", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c2d5a94e720159a5b5c86603d75bf25e89bf55d92b8731c96220954a90828497e4646304bf273e313a32b5fcbc68d371cd956a7a11c2c5a997cb1fb21672f81e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af90db418464b901970a141bb195c1606468fc13de6a39ba19e7bdc746da6314b7358a0ff187134718afcdad2b17f46af270044754cd85f33418fe6342d2019a"} build_url:https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/JUIHbNvwRIuCqm98TYRSyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0353921391006371b4427c0cb636f5592019f653aa49c5abccdd591ce46899c1a389e8f8abe63a40a6291723e8e71627c82008050a309dfba84669f622be3e76", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f36cc6844beb210db25d64710ded8df549fa280271f48eedb85b9fd99f4d706210bffbc23f304feb5d3d3730e4869e05d5faca6d9e3ddad5851352173523e594", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c2d5a94e720159a5b5c86603d75bf25e89bf55d92b8731c96220954a90828497e4646304bf273e313a32b5fcbc68d371cd956a7a11c2c5a997cb1fb21672f81e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af90db418464b901970a141bb195c1606468fc13de6a39ba19e7bdc746da6314b7358a0ff187134718afcdad2b17f46af270044754cd85f33418fe6342d2019a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-30 19:17:30.383663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 19:17:30.388021) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504144604.27295-100773530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.40 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-30 19:17:30.795914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 19:17:30.800377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-30 19:17:30.800853) ========= ========= Total master_lag: 0.05 =========