builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1503541455.05 results: success (0) revision: c142cf8ec91dd97734f938d77e249ae311f51e98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.047499) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.048020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.048331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.066126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.066614) ========= 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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 19:24:15-- 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% 212M=0s 2017-08-23 19:24:15 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.170564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.170940) ========= 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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015766 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:15.221286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 19:24:15.221651) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c142cf8ec91dd97734f938d77e249ae311f51e98 --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 c142cf8ec91dd97734f938d77e249ae311f51e98 --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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 19:24:15,259 truncating revision to first 12 chars 2017-08-23 19:24:15,259 Setting DEBUG logging. 2017-08-23 19:24:15,259 attempt 1/10 2017-08-23 19:24:15,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c142cf8ec91d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 19:24:16,173 unpacking tar archive at: mozilla-beta-c142cf8ec91d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 19:24:16.517987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:16.519616) ========= script_repo_revision: c142cf8ec91dd97734f938d77e249ae311f51e98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:16.519975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:16.520245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 19:24:16.532975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-08-23 19:24:16.533369) ========= /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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:24:16 INFO - MultiFileLogger online at 20170823 19:24:16 in /builds/slave/test 19:24:16 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 19:24:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:24:16 INFO - {'append_to_log': False, 19:24:16 INFO - 'base_work_dir': '/builds/slave/test', 19:24:16 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 19:24:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:24:16 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 19:24:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:24:16 INFO - 'code_coverage': False, 19:24:16 INFO - 'config_files': ('talos/linux_config.py',), 19:24:16 INFO - 'default_actions': ('clobber', 19:24:16 INFO - 'read-buildbot-config', 19:24:16 INFO - 'download-and-extract', 19:24:16 INFO - 'populate-webroot', 19:24:16 INFO - 'create-virtualenv', 19:24:16 INFO - 'install', 19:24:16 INFO - 'setup-mitmproxy', 19:24:16 INFO - 'run-tests'), 19:24:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:24:16 INFO - 'disable_ccov_upload': False, 19:24:16 INFO - 'download_minidump_stackwalk': True, 19:24:16 INFO - 'download_symbols': 'ondemand', 19:24:16 INFO - 'enable_stylo': False, 19:24:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:24:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:24:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:24:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:24:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:24:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:24:16 INFO - 'gecko_profile': False, 19:24:16 INFO - 'gecko_profile_interval': 0, 19:24:16 INFO - 'installer_path': 'installer.exe', 19:24:16 INFO - 'log_level': 'info', 19:24:16 INFO - 'log_name': 'talos', 19:24:16 INFO - 'log_to_console': True, 19:24:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:24:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:24:16 INFO - 'opt_config_files': (), 19:24:16 INFO - 'pip_index': False, 19:24:16 INFO - 'suite': 'dromaeojs-e10s', 19:24:16 INFO - 'system_bits': '32', 19:24:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:24:16 INFO - 'title': 'talos-linux64-ix-048', 19:24:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:24:16 INFO - 'use_talos_json': True, 19:24:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:24:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:24:16 INFO - 'work_dir': 'build'} 19:24:16 INFO - [mozharness: 2017-08-24 02:24:16.670783Z] Running clobber step. 19:24:16 INFO - Running pre-action listener: _resource_record_pre_action 19:24:16 INFO - Running main action method: clobber 19:24:16 INFO - rmtree: /builds/slave/test/build 19:24:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:24:17 INFO - Running post-action listener: _resource_record_post_action 19:24:17 INFO - [mozharness: 2017-08-24 02:24:17.730464Z] Finished clobber step (success) 19:24:17 INFO - [mozharness: 2017-08-24 02:24:17.730568Z] Running read-buildbot-config step. 19:24:17 INFO - Running pre-action listener: _resource_record_pre_action 19:24:17 INFO - Running main action method: read_buildbot_config 19:24:17 INFO - Using buildbot properties: 19:24:17 INFO - { 19:24:17 INFO - "project": "", 19:24:17 INFO - "product": "firefox", 19:24:17 INFO - "who": "ryanvm@gmail.com", 19:24:17 INFO - "installer_path": "public/build/target.tar.bz2", 19:24:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:24:17 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 19:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 19:24:17 INFO - "stage_platform": "linux64", 19:24:17 INFO - "basedir": "/builds/slave/test", 19:24:17 INFO - "buildnumber": 61, 19:24:17 INFO - "platform": "ubuntu64_hw", 19:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:24:17 INFO - "slavebuilddir": "test", 19:24:17 INFO - "taskId": "SBvuiV_qQayXPuRrUkQIMA", 19:24:17 INFO - "branch": "mozilla-beta", 19:24:17 INFO - "script_repo_revision": "production", 19:24:17 INFO - "revision": "c142cf8ec91dd97734f938d77e249ae311f51e98", 19:24:17 INFO - "slavename": "talos-linux64-ix-048", 19:24:17 INFO - "repo_path": "releases/mozilla-beta" 19:24:17 INFO - } 19:24:17 INFO - Finding installer, test and symbols from parent task. 19:24:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SBvuiV_qQayXPuRrUkQIMA'}, attempt #1 19:24:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SBvuiV_qQayXPuRrUkQIMA'}, attempt #1 19:24:18 INFO - Task dependencies: DeVpKF0aS6G-BU4rl_C_jQ 19:24:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ'}, attempt #1 19:24:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 19:24:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.test_packages.json 19:24:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.crashreporter-symbols.zip 19:24:19 INFO - Running post-action listener: _resource_record_post_action 19:24:19 INFO - [mozharness: 2017-08-24 02:24:19.128006Z] Finished read-buildbot-config step (success) 19:24:19 INFO - [mozharness: 2017-08-24 02:24:19.128231Z] Running download-and-extract step. 19:24:19 INFO - Running pre-action listener: _resource_record_pre_action 19:24:19 INFO - Running main action method: download_and_extract 19:24:19 INFO - mkdir: /builds/slave/test/build/tests 19:24:19 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')]} 19:24:19 INFO - trying https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.test_packages.json 19:24:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:24:19 INFO - Downloaded 989 bytes. 19:24:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:24:19 INFO - Using the following test package requirements: 19:24:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:24:19 INFO - u'common': [u'target.common.tests.zip'], 19:24:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:24:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:24:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:24:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:24:19 INFO - u'mozbase': [u'target.common.tests.zip'], 19:24:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:24:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:24:19 INFO - u'web-platform': [u'target.common.tests.zip', 19:24:19 INFO - u'target.web-platform.tests.tar.gz'], 19:24:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:24:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:24:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip 19:24:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:24:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip into memory 19:24:21 INFO - Content-Length response header: 72856156 19:24:21 INFO - Bytes received: 72856156 19:24:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:24:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip 19:24:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:24:32 INFO - Fetch https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.common.tests.zip into memory 19:24:33 INFO - Content-Length response header: 72856156 19:24:33 INFO - Bytes received: 72856156 19:24:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.talos.tests.zip 19:24:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:24:48 INFO - Fetch https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.talos.tests.zip into memory 19:24:48 INFO - Content-Length response header: 14496472 19:24:48 INFO - Bytes received: 14496472 19:24:48 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')]} 19:24:48 INFO - trying https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 19:24:48 INFO - Downloading https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:24:50 INFO - Downloaded 54151677 bytes. 19:24:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 19:24:50 INFO - mkdir: /builds/slave/test/properties 19:24:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:24:50 INFO - Writing to file /builds/slave/test/properties/build_url 19:24:50 INFO - Contents: 19:24:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 19:24:50 INFO - Running post-action listener: _resource_record_post_action 19:24:50 INFO - Running post-action listener: set_extra_try_arguments 19:24:50 INFO - [mozharness: 2017-08-24 02:24:50.026534Z] Finished download-and-extract step (success) 19:24:50 INFO - [mozharness: 2017-08-24 02:24:50.026633Z] Running populate-webroot step. 19:24:50 INFO - Running pre-action listener: _resource_record_pre_action 19:24:50 INFO - Running main action method: populate_webroot 19:24:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:24:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:24:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:24:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:24:50 INFO - 'tests': ['damp', 'tps']}, 19:24:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:24:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:24:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:24:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:24:50 INFO - 'other-e10s': {'tests': ['a11yr', 19:24:50 INFO - 'ts_paint', 19:24:50 INFO - 'tpaint', 19:24:50 INFO - 'sessionrestore', 19:24:50 INFO - 'sessionrestore_many_windows', 19:24:50 INFO - 'sessionrestore_no_auto_restore', 19:24:50 INFO - 'tabpaint']}, 19:24:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:24:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:24:50 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:24:50 INFO - 'talos_options': ['--mitmproxy', 19:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:24:50 INFO - '--firstNonBlankPaint'], 19:24:50 INFO - 'tests': ['quantum_pageload_google', 19:24:50 INFO - 'quantum_pageload_youtube', 19:24:50 INFO - 'quantum_pageload_amazon', 19:24:50 INFO - 'quantum_pageload_facebook']}, 19:24:50 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:24:50 INFO - 'talos_options': ['--stylo', 19:24:50 INFO - '--mitmproxy', 19:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:24:50 INFO - '--firstNonBlankPaint'], 19:24:50 INFO - 'tests': ['quantum_pageload_google', 19:24:50 INFO - 'quantum_pageload_youtube', 19:24:50 INFO - 'quantum_pageload_amazon', 19:24:50 INFO - 'quantum_pageload_facebook']}, 19:24:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:24:50 INFO - 'tsvgr_opacity', 19:24:50 INFO - 'tart', 19:24:50 INFO - 'tscrollx', 19:24:50 INFO - 'cart', 19:24:50 INFO - 'tsvg_static']}, 19:24:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:24:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:24:50 INFO - 'talos_options': ['--stylo', 19:24:50 INFO - '--stylo-threads=1', 19:24:50 INFO - '--mitmproxy', 19:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:24:50 INFO - '--firstNonBlankPaint'], 19:24:50 INFO - 'tests': ['tp6_google', 19:24:50 INFO - 'tp6_youtube', 19:24:50 INFO - 'tp6_amazon', 19:24:50 INFO - 'tp6_facebook']}, 19:24:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:24:50 INFO - 'talos_options': ['--xperf_path', 19:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:24:50 INFO - 'tests': ['tp5n']}}} 19:24:50 INFO - Running post-action listener: _resource_record_post_action 19:24:50 INFO - [mozharness: 2017-08-24 02:24:50.035427Z] Finished populate-webroot step (success) 19:24:50 INFO - [mozharness: 2017-08-24 02:24:50.035519Z] Running create-virtualenv step. 19:24:50 INFO - Running pre-action listener: _resource_record_pre_action 19:24:50 INFO - Running main action method: create_virtualenv 19:24:50 INFO - Creating virtualenv /builds/slave/test/build/venv 19:24:50 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 19:24:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:24:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:24:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:24:50 INFO - Using real prefix '/usr' 19:24:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:24:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:24:52 INFO - Installing pip.................done. 19:24:52 INFO - Return code: 0 19:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:24:52 INFO - Reading from file tmpfile_stdout 19:24:52 INFO - Output received: 19:24:52 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) 19:24:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:24: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')]} 19:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24: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')]} 19:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:52 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:52 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 19:24:52 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 19:24:52 INFO - Using env: {'DISPLAY': ':0', 19:24:52 INFO - 'HOME': '/home/cltbld', 19:24:52 INFO - 'LANG': 'en_US.UTF-8', 19:24:52 INFO - 'LANGUAGE': 'en_US:en', 19:24:52 INFO - 'LOGNAME': 'cltbld', 19:24:52 INFO - 'MAIL': '/var/mail/cltbld', 19:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:52 INFO - 'MOZ_NO_REMOTE': '1', 19:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:52 INFO - 'NO_EM_RESTART': '1', 19:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:52 INFO - 'PWD': '/builds/slave/test', 19:24:52 INFO - 'SHELL': '/bin/bash', 19:24:52 INFO - 'SHLVL': '1', 19:24:52 INFO - 'TERM': 'linux', 19:24:52 INFO - 'TMOUT': '86400', 19:24:52 INFO - 'USER': 'cltbld', 19:24:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:52 INFO - '_': '/tools/buildbot/bin/python'} 19:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:53 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 19:24:53 INFO - Cleaning up... 19:24:53 INFO - Return code: 0 19:24:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:24:53 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')]} 19:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:53 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')]} 19:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:53 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:53 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 19:24:53 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 19:24:53 INFO - Using env: {'DISPLAY': ':0', 19:24:53 INFO - 'HOME': '/home/cltbld', 19:24:53 INFO - 'LANG': 'en_US.UTF-8', 19:24:53 INFO - 'LANGUAGE': 'en_US:en', 19:24:53 INFO - 'LOGNAME': 'cltbld', 19:24:53 INFO - 'MAIL': '/var/mail/cltbld', 19:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:53 INFO - 'MOZ_NO_REMOTE': '1', 19:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:53 INFO - 'NO_EM_RESTART': '1', 19:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:53 INFO - 'PWD': '/builds/slave/test', 19:24:53 INFO - 'SHELL': '/bin/bash', 19:24:53 INFO - 'SHLVL': '1', 19:24:53 INFO - 'TERM': 'linux', 19:24:53 INFO - 'TMOUT': '86400', 19:24:53 INFO - 'USER': 'cltbld', 19:24:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:53 INFO - '_': '/tools/buildbot/bin/python'} 19:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:53 INFO - Downloading/unpacking psutil>=3.1.1 19:24:53 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 19:24:53 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 19:24:53 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 19:24:53 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 19:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:54 INFO - Installing collected packages: psutil 19:24:54 INFO - Running setup.py install for psutil 19:24:54 INFO - building 'psutil._psutil_linux' extension 19:24:54 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 19:24:54 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 19:24:54 INFO - building 'psutil._psutil_posix' extension 19:24:54 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 19:24:54 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 19:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:24:55 INFO - Successfully installed psutil 19:24:55 INFO - Cleaning up... 19:24:55 INFO - Return code: 0 19:24:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:24:55 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')]} 19:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:55 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')]} 19:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:55 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:55 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 19:24:55 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 19:24:55 INFO - Using env: {'DISPLAY': ':0', 19:24:55 INFO - 'HOME': '/home/cltbld', 19:24:55 INFO - 'LANG': 'en_US.UTF-8', 19:24:55 INFO - 'LANGUAGE': 'en_US:en', 19:24:55 INFO - 'LOGNAME': 'cltbld', 19:24:55 INFO - 'MAIL': '/var/mail/cltbld', 19:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:55 INFO - 'MOZ_NO_REMOTE': '1', 19:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:55 INFO - 'NO_EM_RESTART': '1', 19:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:55 INFO - 'PWD': '/builds/slave/test', 19:24:55 INFO - 'SHELL': '/bin/bash', 19:24:55 INFO - 'SHLVL': '1', 19:24:55 INFO - 'TERM': 'linux', 19:24:55 INFO - 'TMOUT': '86400', 19:24:55 INFO - 'USER': 'cltbld', 19:24:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:55 INFO - '_': '/tools/buildbot/bin/python'} 19:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:24:55 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 19:24:55 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 19:24:55 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 19:24:55 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 19:24:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:56 INFO - Installing collected packages: mozsystemmonitor 19:24:56 INFO - Running setup.py install for mozsystemmonitor 19:24:56 INFO - Successfully installed mozsystemmonitor 19:24:56 INFO - Cleaning up... 19:24:56 INFO - Return code: 0 19:24:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:56 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')]} 19:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:56 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')]} 19:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:56 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:56 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 19:24:56 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 19:24:56 INFO - Using env: {'DISPLAY': ':0', 19:24:56 INFO - 'HOME': '/home/cltbld', 19:24:56 INFO - 'LANG': 'en_US.UTF-8', 19:24:56 INFO - 'LANGUAGE': 'en_US:en', 19:24:56 INFO - 'LOGNAME': 'cltbld', 19:24:56 INFO - 'MAIL': '/var/mail/cltbld', 19:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:56 INFO - 'MOZ_NO_REMOTE': '1', 19:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:56 INFO - 'NO_EM_RESTART': '1', 19:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:56 INFO - 'PWD': '/builds/slave/test', 19:24:56 INFO - 'SHELL': '/bin/bash', 19:24:56 INFO - 'SHLVL': '1', 19:24:56 INFO - 'TERM': 'linux', 19:24:56 INFO - 'TMOUT': '86400', 19:24:56 INFO - 'USER': 'cltbld', 19:24:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:56 INFO - '_': '/tools/buildbot/bin/python'} 19:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:56 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:56 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 19:24:56 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 19:24:56 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 19:24:56 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 19:24:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:24:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:24:57 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 19:24:57 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 19:24:57 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 19:24:57 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 19:24:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:24:58 INFO - warning: no files found matching '*.txt' 19:24:58 INFO - no previously-included directories found matching 'build' 19:24:58 INFO - no previously-included directories found matching 'dist' 19:24:58 INFO - no previously-included directories found matching '.git*' 19:24:58 INFO - Installing collected packages: jsonschema, functools32 19:24:58 INFO - Running setup.py install for functools32 19:24:58 INFO - warning: no files found matching '*.txt' 19:24:58 INFO - no previously-included directories found matching 'build' 19:24:58 INFO - no previously-included directories found matching 'dist' 19:24:58 INFO - no previously-included directories found matching '.git*' 19:24:58 INFO - Successfully installed jsonschema functools32 19:24:58 INFO - Cleaning up... 19:24:58 INFO - Return code: 0 19:24:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:24:58 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')]} 19:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:58 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')]} 19:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:58 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:58 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 19:24:58 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 19:24:58 INFO - Using env: {'DISPLAY': ':0', 19:24:58 INFO - 'HOME': '/home/cltbld', 19:24:58 INFO - 'LANG': 'en_US.UTF-8', 19:24:58 INFO - 'LANGUAGE': 'en_US:en', 19:24:58 INFO - 'LOGNAME': 'cltbld', 19:24:58 INFO - 'MAIL': '/var/mail/cltbld', 19:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:58 INFO - 'MOZ_NO_REMOTE': '1', 19:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:58 INFO - 'NO_EM_RESTART': '1', 19:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:58 INFO - 'PWD': '/builds/slave/test', 19:24:58 INFO - 'SHELL': '/bin/bash', 19:24:58 INFO - 'SHLVL': '1', 19:24:58 INFO - 'TERM': 'linux', 19:24:58 INFO - 'TMOUT': '86400', 19:24:58 INFO - 'USER': 'cltbld', 19:24:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:58 INFO - '_': '/tools/buildbot/bin/python'} 19:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:24:58 INFO - Cleaning up... 19:24:58 INFO - Return code: 0 19:24:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:24:58 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')]} 19:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:58 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')]} 19:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:58 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:24:58 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 19:24:58 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 19:24:58 INFO - Using env: {'DISPLAY': ':0', 19:24:58 INFO - 'HOME': '/home/cltbld', 19:24:58 INFO - 'LANG': 'en_US.UTF-8', 19:24:58 INFO - 'LANGUAGE': 'en_US:en', 19:24:58 INFO - 'LOGNAME': 'cltbld', 19:24:58 INFO - 'MAIL': '/var/mail/cltbld', 19:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:58 INFO - 'MOZ_NO_REMOTE': '1', 19:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:24:58 INFO - 'NO_EM_RESTART': '1', 19:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:58 INFO - 'PWD': '/builds/slave/test', 19:24:58 INFO - 'SHELL': '/bin/bash', 19:24:58 INFO - 'SHLVL': '1', 19:24:58 INFO - 'TERM': 'linux', 19:24:58 INFO - 'TMOUT': '86400', 19:24:58 INFO - 'USER': 'cltbld', 19:24:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:58 INFO - '_': '/tools/buildbot/bin/python'} 19:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:24:58 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 19:24:58 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 19:24:58 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 19:24:58 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 19:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:24:59 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 19:24:59 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 19:24:59 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 19:24:59 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 19:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:25:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:25:00 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 19:25:00 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 19:25:00 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 19:25:00 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 19:25:00 INFO - Downloading docopt-0.6.1.tar.gz 19:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:25:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:25:00 INFO - Running setup.py install for blobuploader 19:25:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:25:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:25:00 INFO - Running setup.py install for requests 19:25:00 INFO - Running setup.py install for docopt 19:25:01 INFO - Successfully installed blobuploader requests docopt 19:25:01 INFO - Cleaning up... 19:25:01 INFO - Return code: 0 19:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:01 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')]} 19:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:01 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')]} 19:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:01 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:25:01 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 19:25:01 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 19:25:01 INFO - Using env: {'DISPLAY': ':0', 19:25:01 INFO - 'HOME': '/home/cltbld', 19:25:01 INFO - 'LANG': 'en_US.UTF-8', 19:25:01 INFO - 'LANGUAGE': 'en_US:en', 19:25:01 INFO - 'LOGNAME': 'cltbld', 19:25:01 INFO - 'MAIL': '/var/mail/cltbld', 19:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:01 INFO - 'MOZ_NO_REMOTE': '1', 19:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:01 INFO - 'NO_EM_RESTART': '1', 19:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:01 INFO - 'PWD': '/builds/slave/test', 19:25:01 INFO - 'SHELL': '/bin/bash', 19:25:01 INFO - 'SHLVL': '1', 19:25:01 INFO - 'TERM': 'linux', 19:25:01 INFO - 'TMOUT': '86400', 19:25:01 INFO - 'USER': 'cltbld', 19:25:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:01 INFO - '_': '/tools/buildbot/bin/python'} 19:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:01 INFO - Running setup.py (path:/tmp/pip-O0HaQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:01 INFO - Running setup.py (path:/tmp/pip-m5oTQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:01 INFO - Running setup.py (path:/tmp/pip-H2tG7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:01 INFO - Running setup.py (path:/tmp/pip-ikRPMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:01 INFO - Running setup.py (path:/tmp/pip-71FJWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:01 INFO - Running setup.py (path:/tmp/pip-sCoGPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:01 INFO - Running setup.py (path:/tmp/pip-rOrogr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:01 INFO - Running setup.py (path:/tmp/pip-NwZcbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:01 INFO - Running setup.py (path:/tmp/pip-qzCk_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:01 INFO - Running setup.py (path:/tmp/pip-VWYLrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:02 INFO - Running setup.py (path:/tmp/pip-s8prxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:02 INFO - Running setup.py (path:/tmp/pip-x4L8yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:02 INFO - Running setup.py (path:/tmp/pip-gnwXf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:02 INFO - Running setup.py (path:/tmp/pip-jiMmGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:02 INFO - Running setup.py (path:/tmp/pip-nTITMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:02 INFO - Running setup.py (path:/tmp/pip-rcp7Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:02 INFO - Running setup.py (path:/tmp/pip-MCCoYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:25:02 INFO - Running setup.py install for manifestparser 19:25:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:25:02 INFO - Running setup.py install for mozcrash 19:25:02 INFO - Running setup.py install for mozdebug 19:25:02 INFO - Running setup.py install for mozdevice 19:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:25:02 INFO - Running setup.py install for mozfile 19:25:03 INFO - Running setup.py install for mozhttpd 19:25:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for mozinfo 19:25:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for mozInstall 19:25:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for mozleak 19:25:03 INFO - Running setup.py install for mozlog 19:25:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for moznetwork 19:25:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for mozprocess 19:25:03 INFO - Running setup.py install for mozprofile 19:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:25:03 INFO - Running setup.py install for mozrunner 19:25:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:25:04 INFO - Running setup.py install for mozscreenshot 19:25:04 INFO - Running setup.py install for moztest 19:25:04 INFO - Running setup.py install for mozversion 19:25:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:25:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:25:04 INFO - Cleaning up... 19:25:04 INFO - Return code: 0 19:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:04 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')]} 19:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:04 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')]} 19:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:04 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:25:04 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 19:25:04 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 19:25:04 INFO - Using env: {'DISPLAY': ':0', 19:25:04 INFO - 'HOME': '/home/cltbld', 19:25:04 INFO - 'LANG': 'en_US.UTF-8', 19:25:04 INFO - 'LANGUAGE': 'en_US:en', 19:25:04 INFO - 'LOGNAME': 'cltbld', 19:25:04 INFO - 'MAIL': '/var/mail/cltbld', 19:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:04 INFO - 'MOZ_NO_REMOTE': '1', 19:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:04 INFO - 'NO_EM_RESTART': '1', 19:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:04 INFO - 'PWD': '/builds/slave/test', 19:25:04 INFO - 'SHELL': '/bin/bash', 19:25:04 INFO - 'SHLVL': '1', 19:25:04 INFO - 'TERM': 'linux', 19:25:04 INFO - 'TMOUT': '86400', 19:25:04 INFO - 'USER': 'cltbld', 19:25:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:04 INFO - '_': '/tools/buildbot/bin/python'} 19:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:25:04 INFO - Running setup.py (path:/tmp/pip-jEYujZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:25:04 INFO - Running setup.py (path:/tmp/pip-odzkAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:25:04 INFO - Running setup.py (path:/tmp/pip-8tf1iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:25:04 INFO - Running setup.py (path:/tmp/pip-ZvdZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:25:04 INFO - Running setup.py (path:/tmp/pip-tzAmI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:25:04 INFO - Running setup.py (path:/tmp/pip-ttqziK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:25:04 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)) 19:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:25:05 INFO - Running setup.py (path:/tmp/pip-nFWslc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:25:05 INFO - Running setup.py (path:/tmp/pip-QZauc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:25:05 INFO - Running setup.py (path:/tmp/pip-mpbVFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:25:05 INFO - Running setup.py (path:/tmp/pip-qYepHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:25:05 INFO - Running setup.py (path:/tmp/pip-dyXGxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:25:05 INFO - Running setup.py (path:/tmp/pip-BN8GDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:25:05 INFO - Running setup.py (path:/tmp/pip-noF5CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:25:05 INFO - Running setup.py (path:/tmp/pip-767SRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:05 INFO - Running setup.py (path:/tmp/pip-uZUSzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:25:05 INFO - Running setup.py (path:/tmp/pip-kjTMEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:25:05 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)) 19:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:25:05 INFO - Running setup.py (path:/tmp/pip-TG7LRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:25:05 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)) 19:25:05 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)) 19:25:05 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)) 19:25:05 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)) 19:25:05 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)) 19:25:05 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)) 19:25:05 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)) 19:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:25:05 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 19:25:05 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 19:25:05 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 19:25:05 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 19:25:06 INFO - Downloading blessings-1.6.tar.gz 19:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:25:07 INFO - Installing collected packages: blessings 19:25:07 INFO - Running setup.py install for blessings 19:25:07 INFO - Successfully installed blessings 19:25:07 INFO - Cleaning up... 19:25:07 INFO - Return code: 0 19:25:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:07 INFO - Reading from file tmpfile_stdout 19:25:07 INFO - Current package versions: 19:25:07 INFO - argparse == 1.2.1 19:25:07 INFO - blessings == 1.6 19:25:07 INFO - blobuploader == 1.2.4 19:25:07 INFO - docopt == 0.6.1 19:25:07 INFO - functools32 == 3.2.3-2 19:25:07 INFO - jsonschema == 2.5.1 19:25:07 INFO - manifestparser == 1.1 19:25:07 INFO - mozInstall == 1.13 19:25:07 INFO - mozcrash == 1.0 19:25:07 INFO - mozdebug == 0.1 19:25:07 INFO - mozdevice == 0.51 19:25:07 INFO - mozfile == 1.2 19:25:07 INFO - mozhttpd == 0.7 19:25:07 INFO - mozinfo == 0.10 19:25:07 INFO - mozleak == 0.1 19:25:07 INFO - mozlog == 3.5 19:25:07 INFO - moznetwork == 0.27 19:25:07 INFO - mozprocess == 0.25 19:25:07 INFO - mozprofile == 0.28 19:25:07 INFO - mozrunner == 6.13 19:25:07 INFO - mozscreenshot == 0.1 19:25:07 INFO - mozsystemmonitor == 0.3 19:25:07 INFO - moztest == 0.8 19:25:07 INFO - mozversion == 1.4 19:25:07 INFO - psutil == 3.1.1 19:25:07 INFO - requests == 1.2.3 19:25:07 INFO - wsgiref == 0.1.2 19:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:25:07 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')]} 19:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:07 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')]} 19:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:07 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:25:07 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 19:25:07 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 19:25:07 INFO - Using env: {'DISPLAY': ':0', 19:25:07 INFO - 'HOME': '/home/cltbld', 19:25:07 INFO - 'LANG': 'en_US.UTF-8', 19:25:07 INFO - 'LANGUAGE': 'en_US:en', 19:25:07 INFO - 'LOGNAME': 'cltbld', 19:25:07 INFO - 'MAIL': '/var/mail/cltbld', 19:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:07 INFO - 'MOZ_NO_REMOTE': '1', 19:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:07 INFO - 'NO_EM_RESTART': '1', 19:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:07 INFO - 'PWD': '/builds/slave/test', 19:25:07 INFO - 'SHELL': '/bin/bash', 19:25:07 INFO - 'SHLVL': '1', 19:25:07 INFO - 'TERM': 'linux', 19:25:07 INFO - 'TMOUT': '86400', 19:25:07 INFO - 'USER': 'cltbld', 19:25:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:07 INFO - '_': '/tools/buildbot/bin/python'} 19:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 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)) 19:25:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:25:07 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 19:25:07 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 19:25:07 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 19:25:07 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 19:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:25:08 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)) 19:25:08 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)) 19:25:08 INFO - Installing collected packages: simplejson 19:25:08 INFO - Running setup.py install for simplejson 19:25:08 INFO - building 'simplejson._speedups' extension 19:25:08 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 19:25:09 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 19:25:09 INFO - Successfully installed simplejson 19:25:09 INFO - Cleaning up... 19:25:09 INFO - Return code: 0 19:25:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:25:09 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')]} 19:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:25:09 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')]} 19:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:25:09 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 0xdf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, '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': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', '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 19:25:09 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 19:25:09 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 19:25:09 INFO - Using env: {'DISPLAY': ':0', 19:25:09 INFO - 'HOME': '/home/cltbld', 19:25:09 INFO - 'LANG': 'en_US.UTF-8', 19:25:09 INFO - 'LANGUAGE': 'en_US:en', 19:25:09 INFO - 'LOGNAME': 'cltbld', 19:25:09 INFO - 'MAIL': '/var/mail/cltbld', 19:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:09 INFO - 'MOZ_NO_REMOTE': '1', 19:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:09 INFO - 'NO_EM_RESTART': '1', 19:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:09 INFO - 'PWD': '/builds/slave/test', 19:25:09 INFO - 'SHELL': '/bin/bash', 19:25:09 INFO - 'SHLVL': '1', 19:25:09 INFO - 'TERM': 'linux', 19:25:09 INFO - 'TMOUT': '86400', 19:25:09 INFO - 'USER': 'cltbld', 19:25:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:09 INFO - '_': '/tools/buildbot/bin/python'} 19:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:25:10 INFO - Cleaning up... 19:25:10 INFO - Return code: 0 19:25:10 INFO - Running post-action listener: _resource_record_post_action 19:25:10 INFO - Running post-action listener: _start_resource_monitoring 19:25:10 INFO - Starting resource monitoring. 19:25:10 INFO - [mozharness: 2017-08-24 02:25:10.082018Z] Finished create-virtualenv step (success) 19:25:10 INFO - [mozharness: 2017-08-24 02:25:10.082525Z] Running install step. 19:25:10 INFO - Running pre-action listener: _resource_record_pre_action 19:25:10 INFO - Running main action method: install 19:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:25:10 INFO - Reading from file tmpfile_stdout 19:25:10 INFO - Detecting whether we're running mozinstall >=1.0... 19:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:25:10 INFO - Reading from file tmpfile_stdout 19:25:10 INFO - Output received: 19:25:10 INFO - Usage: mozinstall [options] installer 19:25:10 INFO - Options: 19:25:10 INFO - -h, --help show this help message and exit 19:25:10 INFO - -d DEST, --destination=DEST 19:25:10 INFO - Directory to install application into. [default: 19:25:10 INFO - "/builds/slave/test"] 19:25:10 INFO - --app=APP Application being installed. [default: firefox] 19:25:10 INFO - mkdir: /builds/slave/test/build/application 19:25:10 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'] 19:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:25:25 INFO - Reading from file tmpfile_stdout 19:25:25 INFO - Output received: 19:25:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:25:25 INFO - Running post-action listener: _resource_record_post_action 19:25:25 INFO - [mozharness: 2017-08-24 02:25:25.444261Z] Finished install step (success) 19:25:25 INFO - [mozharness: 2017-08-24 02:25:25.444409Z] Running setup-mitmproxy step. 19:25:25 INFO - Running pre-action listener: _resource_record_pre_action 19:25:25 INFO - Running main action method: setup_mitmproxy 19:25:25 INFO - Skipping: mitmproxy is not required 19:25:25 INFO - Running post-action listener: _resource_record_post_action 19:25:25 INFO - [mozharness: 2017-08-24 02:25:25.444944Z] Finished setup-mitmproxy step (success) 19:25:25 INFO - [mozharness: 2017-08-24 02:25:25.445047Z] Running run-tests step. 19:25:25 INFO - Running pre-action listener: _resource_record_pre_action 19:25:25 INFO - Running pre-action listener: _set_gcov_prefix 19:25:25 INFO - Running main action method: run_tests 19:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:25:25 INFO - Python 2.7.3 19:25:25 INFO - Return code: 0 19:25:25 INFO - grabbing minidump binary from tooltool 19:25:25 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')]} 19:25:25 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 0x1160eb0>, '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 0x1161db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1162240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:25:25 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 19:25:25 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 19:25:25 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 19:25:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:25:25 INFO - Return code: 0 19:25:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:25:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:25:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:25:25 INFO - ENV: RUST_BACKTRACE is now 1 19:25:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:25:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:25:25 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/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 19:25:25 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/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 19:25:25 INFO - Using env: {'DISPLAY': ':0', 19:25:25 INFO - 'HOME': '/home/cltbld', 19:25:25 INFO - 'LANG': 'en_US.UTF-8', 19:25:25 INFO - 'LANGUAGE': 'en_US:en', 19:25:25 INFO - 'LOGNAME': 'cltbld', 19:25:25 INFO - 'MAIL': '/var/mail/cltbld', 19:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:25:25 INFO - 'MOZ_NO_REMOTE': '1', 19:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:25:25 INFO - 'NO_EM_RESTART': '1', 19:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:25:25 INFO - 'PWD': '/builds/slave/test', 19:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:25:25 INFO - 'RUST_BACKTRACE': '1', 19:25:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:25:25 INFO - 'SHELL': '/bin/bash', 19:25:25 INFO - 'SHLVL': '1', 19:25:25 INFO - 'TERM': 'linux', 19:25:25 INFO - 'TMOUT': '86400', 19:25:25 INFO - 'USER': 'cltbld', 19:25:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900', 19:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:25:25 INFO - '_': '/tools/buildbot/bin/python'} 19:25:25 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/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 19:25:25 INFO - mozversion application_buildid: 20170824011326 19:25:25 INFO - mozversion application_changeset: c142cf8ec91dd97734f938d77e249ae311f51e98 19:25:25 INFO - mozversion application_display_name: Firefox 19:25:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:25:25 INFO - mozversion application_name: Firefox 19:25:25 INFO - mozversion application_remotingname: firefox 19:25:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:25:25 INFO - mozversion application_vendor: Mozilla 19:25:25 INFO - mozversion application_version: 56.0 19:25:25 INFO - mozversion platform_buildid: 20170824011326 19:25:25 INFO - mozversion platform_changeset: c142cf8ec91dd97734f938d77e249ae311f51e98 19:25:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:25:25 INFO - mozversion platform_version: 56.0 19:25:25 INFO - using testdate: 1503541525 19:25:25 INFO - actual date: 1503541525 19:25:25 INFO - starting webserver on 'localhost:59516' 19:25:25 INFO - SUITE-START | Running 2 tests 19:25:25 INFO - TEST-START | dromaeo_css 19:25:25 INFO - Initialising browser for dromaeo_css test... 19:25:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59516/getInfo.html -profile /tmp/tmpsAK2Wa/profile 19:25:25 INFO - TEST-INFO | started process 6948 (/builds/slave/test/build/application/firefox/firefox http://localhost:59516/getInfo.html) 19:25:31 INFO - TEST-INFO | 6948: exit 0 19:25:31 INFO - Browser initialized. 19:25:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:25:31 INFO - TEST-INFO | started process 7109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsAK2Wa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:32 INFO - PID 7109 | 1503541532176 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:25:43 INFO - PID 7109 | RSS: Main: 150765568 19:25:43 INFO - PID 7109 | 19:28:41 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59516/tests/dromaeo/cssquery-ext.html) 19:28:42 INFO - PID 7109 | RSS: Main: 160071680 19:28:42 INFO - PID 7109 | 19:31:43 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-ext.html (next: http://localhost:59516/tests/dromaeo/cssquery-jquery.html) 19:31:44 INFO - PID 7109 | RSS: Main: 155926528 19:31:44 INFO - PID 7109 | 19:34:45 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59516/tests/dromaeo/cssquery-mootools.html) 19:34:46 INFO - PID 7109 | RSS: Main: 158916608 19:34:46 INFO - PID 7109 | 19:37:48 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59516/tests/dromaeo/cssquery-prototype.html) 19:37:48 INFO - PID 7109 | RSS: Main: 158863360 19:37:48 INFO - PID 7109 | 19:40:51 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59516/tests/dromaeo/cssquery-yui.html) 19:40:52 INFO - PID 7109 | RSS: Main: 160763904 19:40:52 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | Cycle 1(1): loaded http://localhost:59516/tests/dromaeo/cssquery-yui.html (next: http://localhost:59516/tests/dromaeo/cssquery-dojo.html) 19:43:54 INFO - PID 7109 | RSS: Main: 163557376 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | __start_tp_report 19:43:54 INFO - PID 7109 | _x_x_mozilla_page_load 19:43:54 INFO - PID 7109 | _x_x_mozilla_page_load_details 19:43:54 INFO - PID 7109 | |i|pagename|runs| 19:43:54 INFO - PID 7109 | |0;dojo.html;3575.1598374382;3616.4213725803875;3620.601733809279;3631.854725810968;3640.199156185639;6417.839554011152;6484.2867284598715;6514.283428822826;6538.542302038859;6539.378759017892;6465.094886715863;6507.739690412378;6507.8373040674005;6550.181227346582;6576.506761992846;5557.638753481011;5600.411956744544;5613.186088017235;5659.60382773206;5669.744861481243;5656.377798442189;5683.914741278863;5685.545156387499;5688.516476099537;5695.202671625955;5619.859503512404;5669.801556945507;5702.429757024285;5712.171735098408;5740.827775166731;5548.9722551386985;5603.2435621191025;5623.662580245157;5672;5675.5459563234845;5623.718814059322;5656.377798442168;5685.943140568583;5689.459501347365;5701.771929122871;6361.950278204091;6377.968110159466;6397.264314603787;6441.83895402614;6508.446782023534;6805.251422343587;6925.238223795379;6930.410915072174;6950.165980082423;7043.753468628624;7049.154101507801;7064.293570642946;7065.505414620979;7068.11648543932;7099.787006389816;6478.481721462272;6490.8052758417325;6525.738970441224;6566.70449829754;6568.080468734381;7044.260352662999;7117.822054448577;7122.18094919091;7124.145102587619;7170.749023784142;6892;6901.827454313682;6933.722651094001;6937.306269373023;6940.236573976858;6996.475264355194;7042.753503627348;7070.292970702889;7074.257202993612;7113.502054856111;6802.183737951477;6819.181698196248;6872.896906546406;6920.861582768316;6922.2731613180895;6959.234484206733;6988.6855091521;7007.509474336849;7008.719651213996;7036.788896333118;5046.747662616928;5131.871703207375;5137.794488220504;5139.537441630271;5168.896622067613;4545.0909818036525;4601.7699115044115;4614.423197100363;4619.168549661026;4639.791209395586;6433.324500927429;6568.310327415648;6569.24453687832;6574.211094668574;6592.637404942774;7004.544704594185;7065.576065435987;7071.504994650325;7082.256363081905;7114.217436082027;6626.7017984190825;6628;6677.732890684415;6716.966415167893;6724.058631791553;5869;5881.647101173943;5933.614315069507;5952.375000624958;5953.1070339449425;7048.365647091787;7167.960645706447;7184.964075179695;7257.092863392076;7269.20038795732;7009.334113259232;7062;7080.752173674103;7088.362047415551;7095.325944035309;7211.098612673416;7218.242084581043;7223.061002069698;7280.490365674564;7304.671289792079;6876.312368763083;6889.2421833599265;6935.3411425914455;6960.303969603202;6968;6932.064171337007;7002.684879180347;7050.682719277543;7094.53885497441;7134.821629459305;6772.627505487246;6854.760083397057;6856.108705868205;6856.657167141722;6866.004429357815;6768.492363072691;6905.964105384232;6924.238333783381;6927.099477067949;6932.994715766286;6840.7605733801065;6846.349596788297;6854.828629284308;6915.827104322432;6926.896096558455;6866.862662746617;6912.205096413977;6917.100776898971;6948.992396102638;6976.058232138596;6620.569662971891;6629.403353698191;6663.300353462817;6703.128593282842;6729.2934241903895 19:43:54 INFO - PID 7109 | |1;ext.html;931.785689291463;939.1125386509747;968.1238479176343;984.3650845204843;990.9108180263775;37506.62493375065;38342.23315533688;45941.540584594186;46418.535814641844;46465;47233.29150062752;47396.52603473973;47531;47556;47742.522574774244;7868.567228802413;7885.8028549286155;7959.243871832166;8025.197480251957;8043.03483581971;7924.603769811515;7997.7600671979935;8041.597920104001;8049.114597394282;8049.557274349909;8000.439969202158;8008.879866802003;8077.192280771935;8098.716544920929;8105.392095592824;8018.639161237758;8020.077691065544;8034.718784842532;8039.678412863537;8064.354851611857;7897.24976127267;7952.681892724342;7957.084935232407;7971.641276142587;7995.600219988977;41517.79241103775;41696.791516042525;42046.579534204575;42116.1576768466;42383.36424953628;3679.9448008279896;3709.5919448860604;3717.6654101130757;3718.3307004739136;3721.6464435878547;33732;33763.32473350544;33774.6622533774;33816.492752608734;33858.153546161295;5216.504432078947;5248.6588371755715;5260.1583746600745;5262.158054711228;5296.205569164617;211603;214112.92943535338;214515;214838;216264;52444.475555244724;52872;52937.735311323195;52986;52991;55011.44988550063;55365.169522457196;55389.1691624626;55727.442725572226;55781.72109139428;14383.856161438462;14557.12657240569;14673.559793206008;14698.706025879423;14818.259087045604;9831;10106.898931010743;11522.884771152349;11546;11558.422078896021;16212.108334041504;16295.592610184603;16393.262303196385;16396.344146234256;16488.505344839676;6020.909686354708;6044.727987240584;6101.542384321194;6153.7230824613;6164.537659675542;1117.407773879845;1130.4799792095564;1132.2640283815422;1133.7619099989095;1134.2287244673537;26785.598216026774;27003.729962700516;27043;27055.323616909736;27442.5883611746;1212.9696757580955;1224.5285565057518;1232.8027515597462;1242.577523641966;1252.3612957391613;13706;13805.378757955916;13922.373493192628;14040.227787471584;14178.361973711208;296088;297315;297722;298002;298197;59943.40056599378;60193;60383.396166038656;60426.395736042956;60507.09239361413;1540.6225474758755;1544.5289186798134;1558.5168597734964;1598.6243232840272;1599.88800783944;25395;25419.237422877344;25525.74474255308;25529.617055743805;25782.61326080073;41617.58382416137;41794.58205417907;41950.37074443947;41958;41982.58017419909;250789;254918;255311;255636;256045;38529.80735096306;39414.605853941095;41543;41626.1674766509;41816.163676725686;51439.742801285756;52999.47000529945;53022.204666929254;53189.7340513295;53306.46693533015;37371.81314093412;37697.81151094227;37794.62205377911;37901.620983789806;38065;37380.626193738804;37534.62465375311;37650.81174594109;37702;37883.431748524345;43433.3484997719;45053.54946450625;45148.32277515905;45350;45489.772551138354;36827.81586092053;37245.25509489741;37268.881933542034;37363.813180933925;37451;26803.865980669972;26964.32589185286;27141.59287610648;27148.1855544334;27266 19:43:54 INFO - PID 7109 | |2;jquery.html;556.4268803132773;563.8618538458078;565.9066254068078;571.8513186571492;583.588570058109;23550.64674029889;24535.63196552053;24553.877230613867;24579.63130553043;24599.508009839792;24906.12828551001;24992.750072499315;25286.36784080399;25294.114705985296;25464.618030729554;6466.35336466352;6581.177352830896;6594.4065034146915;6626.370494802986;6633.535652504326;6222;6429.935700643004;6437.6781160942;6440.903386449207;6441.0982462455295;6417.326180751024;6417.935820641804;6423.550351475398;6424.293327733945;6426.036094585803;6386.808395748135;6435.6138631682015;6436.839079023015;6438.581492203015;6445.903311450332;5802.767889284423;5875.529957603381;5892.322382925932;5910.7931222407005;5930.644161350289;30749;31894.20264493383;31983.52024719631;32368.190795230308;32460.513092303634;2319.9420014499606;2361.409647588103;2364.5270945810908;2365.3022358404314;2366.8934897929635;20320.28878989243;20815.479613009644;20908.58182836335;20985.950702464816;20988.16047358104;2410.433548116191;2466.2971053249917;2514.270861450177;2514.4719608882156;2531.734167912361;161880;162604.18697906553;165168.17415912964;165675;168919;14765.187914664582;14946.587225881944;15637.921810390875;15676.68646627084;15737.44918927832;23386.7661323388;23445.06219751191;23505.059797608246;23565.057397704244;23628.29115126549;9868.407895526292;9884.25868059884;9935.453550054672;9960.111567645446;9992.150667193224;7785.532868027936;8839.337049721296;8858.202761751474;8928.241099506615;8979.281657467387;8516.74449766508;9580.18568421678;9746.415215087118;9786.217102631772;10035.749106272255;2665.7867370610306;2667.7465640764094;2729.19488750819;2760.7791376689815;2780.708025657317;1057.603398725478;1081.4592703648175;1092.224520590374;1093.1254996003165;1096.6819622309602;21492.24777132793;21733.130674773147;21733.782662173493;22026.33920982373;22104.557908841733;1111.9777604448027;1124.0951034417374;1128.3568366031448;1134.4384529657873;1140.5494829542283;11696.415179241174;12142.575009874612;12192.146549741434;12216.328101954477;12246.203996740362;590456;595959;618471;631736;631810;128310;129745;129808;132576;133565.33217334046;1269.9301538415475;1283.3006011723633;1295.1257900916844;1301.0372324479818;1309.6071178646368;18970.43088707341;19114.426567203005;19343.709844352066;19523.316683915993;19596.8040319595;61538.384616153264;62341.688291560065;62448.687756560925;62966;63845.68077159584;80962;81436;81951;82237.58881205556;82654.58672706598;14487.348069336695;14732.189729564549;14740.336684848993;14769.778453322993;14860.702785944437;23540.76459235386;23662.881685591463;23732.288031359087;23855.880720596288;24889;18308.72536911974;18573.535661608566;19813.405597832087;20024.899875501113;20191.79808201958;17245.22396492186;17352.65294694074;17367.739483908004;17698.469045928643;17856.285748569913;19038.33365832189;19319.323823666666;19395.3211637592;19416.320428784926;19533.902330488258;14752.55742327732;14757.335919883417;14761.630959226106;14789.260536973323;14829.555113346616;19398.806011940265;19602.313919012766;19714.901425492782;19768.901155494706;19824.405267841412 19:43:54 INFO - PID 7109 | |3;mootools.html;1453.498543002664;1490.128274959149;1496.1247670112984;1511.1764088571726;1524.5426372088375;15624;16156.192190390462;16178;16182.433614823483;16225.75661365079;15938.760918586231;17036.574085647866;17082.487525374258;17094;17095.74356384652;3007.7894547381693;3041.194083567845;3084.768642351821;3085.444619968405;3087.1818967973504;2950.7344339009483;2979;2987.671356150822;3052.1453992881916;3055.7860949733526;2995.1912983494553;3015.6682764895845;3040.255137491318;3058.1284333964823;3064.5709600655928;2921.0652591170942;2928.2825707701536;2936.1485169300877;2944.764418846487;2951.513000354939;2936.559516072606;2946.351802603424;2957.1572101951056;2958.689337619562;2964.9407011859644;15793.368265269375;15839.920800395925;16066.5983350416;16082.115483648395;16084.75872861908;8616.741497755078;8905.154010369004;8924.107589241088;8953.462792232422;8956.820863582758;5511.9724401378135;5537;5564.415736347706;5707.429257074301;5755.280589926259;1799.1454059321848;1826.269492203116;1859.237712537853;1882.124811962444;1883.595027069173;28385.290367740767;28411.57382639262;28490.715092848804;28588.857055714798;28648.85675571609;7210.67551960163;7436.628168591549;7479.439042071866;7573.091229052549;7639.197884222188;19084.14121364542;19180.232790688497;19231.326903558307;19261.711074333896;19265.13306901193;8319.916800831914;8569.528675922884;8582.570871456403;8598.312135029182;8605.31157507398;7804.063512378438;7851.607419628996;7915.841683166304;8116.59417029158;8130.512169269863;5489.752961116759;5786.132080188006;5902.58681892272;5947.910781338197;6031.7587296507645;1621.4649165775265;1705.104819969501;1751.8944096294545;1762.5946032412617;1792.6056267621102;991.1377101921374;996.3772642098688;999.7350702063959;1005.7787286796893;1020.7805321855836;8571.785705357292;8607.397482176188;8621.353398495012;8658.653653853775;8726.214640682241;1036.8185567525652;1060.4962642744788;1062.516554967488;1063.9787204255872;1081.1350919264557;6006.249218847644;6123.418275263843;6607.537472376887;6737.663116844138;6751.898721519181;22190.223342183268;23001.424964376023;23391;23907.16324928619;23940.640890386658;22672;22719.545609087727;22777.31668049961;23033.654495182585;23057.308280751604;11782.882171178178;12063.939680301717;12344.506219751289;12379.75240495185;12429.627111186679;9445.811083778424;9532.85700714476;9669.564869581027;9674;9693.176080033276;19649.901750491157;20340.084696188413;20387.490312741706;20519.281825136048;20824.95875206264;20546.28088016972;20567.8971605147;20828.375148745563;20834.687479687513;20904.47738806481;13569;13650.863491364958;13667.17996920188;13693.657658558615;13698;12926.35368231566;14837.703245935238;15074.397024118913;15217.923910380377;15223.391064357302;10089.394636321844;11482.655520334403;11565.248258863146;11714;11770.646880593597;11520.481578329163;11649.825252621047;11662.88337116618;11790.941045295061;11907.702307442383;10152;10206.948965255126;10217.489125543842;10320.638777642747;10323;7939.563324017235;8069.3544516439715;8193;8199.95900020496;8205.71280005197;8267.62795674184;8360;8407.831843362976;8460.703875364332;8483.10927352619 19:43:54 INFO - PID 7109 | |4;prototype.html;509.9469595285735;510.44616590998766;532.8241680245519;537.5914305128107;545.42457707119;6185.876282474348;6224.657643829593;6332.746690132395;6333.873322533553;6335.461485773715;6163.753449862;6186.350433204516;6186.84532886677;6230;6260.968695156518;4948.455669876311;4968.267452900908;4986.825461108862;4988.65079444439;5036.269740887569;4766;4845.466998630148;4945.604351651859;4977.178765503688;4999.225120106389;4810.735409552473;4834.936314010912;4837.637177211705;4847.175980083394;4859.73271470069;4841.346418233528;4841.419029716421;4854.854354369375;4866.343043689109;4869.172240719051;4361.302191649353;4369.868903932887;4373.453318335208;4374.49693285273;4375.7374557526655;5967.403259673998;5990.2212712347555;6017.939820601781;6077.359113039454;6119.908201376983;5771.942280577183;5777.19119323295;5819.7090145492975;5824.184614154022;5865.296164460249;6425.815222824215;6487.286398496161;6610.669466526654;6625.701843417058;6645.136132302818;4907.730074845882;4943.382077240345;4959.975200123977;4962.826301079481;4966.1309270877455;6705.329467053304;6783.3216678332265;6877.312268773083;6885.655717214169;6943.583384996816;5451.182322651554;5452.618316717871;5475.4524547545725;5488.341399032061;5503.798910029983;5540.335159780852;5590.357108932443;5608.719564021782;5611.186377975171;5625.859353516113;5916.26046744157;5933.851653708692;5942.494887934487;5985.431384018511;6004.939950600526;6544.803655890331;6563.343665633399;6597.571157874723;6648.501362397839;6652;1948.908611177745;1953.2870502266571;1960.7549056367955;1966.0857701169025;1974.220183027696;1389.9513517026855;1461.4008256614736;1461.8099647046029;1462.8610282023192;1463.9560813175622;6322.71547780351;6353.174087368612;6380.298167201604;6406.487481001509;6458.354164583598;6639.701213445406;6702.36327548882;6734.764283250062;6748.358905903931;6764.83087922796;6243.594166379171;6302.957633892867;6309.873802524015;6368.936310636835;6436.581622194542;3611.7652352597524;3616.385214513539;3621.8913432596537;3626.7642603230706;3649.872254471081;6965.805771182061;6976.372126508639;7029.121359830021;7048.682809273595;7053.188883278386;6904.620245886525;6943.930560694429;6993.195782484978;7014.684339204748;7019.508634395544;6874.175098988154;6957.199922008933;6988.161420629455;6997.720091196397;7046.823829404306;6708.664566771544;6757.898631520433;6773.221079575912;6818.590884546943;6848.554843935129;6708.664566771739;6738.561993470409;6755.662216889037;6758.7296508139125;6761;6862.073620061228;6893.20728116253;6942.854429019155;6987.7204911802955;6997.370236678723;5279.6040296978645;5291.23277124807;5303.178007408857;5323.893522129613;5356.946430535801;6545.607263564201;6620.404163625297;6691.5650482718465;6732.932670673426;6741.775214179407;6447.615621377508;6492.253390859923;6542.411182993554;6561.343865613591;6607.6212563478075;6434.260060092962;6563.704633291609;6569.835754105994;6587.934120658923;6605.5376123670885;6371.566397560512;6493.675316234264;6509.804705858832;6574.4411725002;6590.5716128451495;6566.0479230512265;6583.30875258091;6725.865482690221;6733.259341472336;6739.494537909774;6402.647854368054;6506.902396463962;6516.641584712696;6519.054737063194;6519.674016299261 19:43:54 INFO - PID 7109 | |5;yui.html;946.6450081219539;960.7982323712022;971.9319647624665;991.2218908157098;993.4486360070158;18681.252749890024;19691.901540492294;20319.1872325107;20341.18635254588;20845.374638760823;19691.409257722255;19845.801541984576;20119.49701257469;20168.294109706163;20172.495687607818;863.7322430046675;877.9648814047431;1079.6545105566183;1081.2863510083346;1085.8914108589117;1090.2858627598935;1094.5512339940626;1096.0135877710045;1096.3257596578087;1097.8847221041794;1144.5193018932068;1149.9080073594093;1151.5624062856102;1151.9136064795173;1157.5022740221702;1141;1142.1319796954292;1142.2860712054965;1145.4730823821053;1147.822087576427;848.1052489623445;850.1328644782287;850.553459433796;850.8808766772656;851.5188918261163;17788.822111778845;17928;18669.25322987079;20562.69155962662;20842.791572084236;20865.269715559883;20977.37067887966;21036.158553657835;21270;21827.345179644635;16832.410865619768;16917.915410422993;17088.316467341414;17264.654706905792;17489.21298541569;3712.1276500022473;3750.5499340079364;3751.4372844073337;3752.7185461090253;3755.962440375589;137559;140005.29997349947;141914;141998;142274;16870.662586748444;17437.21532531039;17485.388011419538;17539.298428062735;17687.91156044237;30610.54084188739;31907.36185276328;32000.199995000312;32206;32254.19364515906;8454.196851299117;9217.861732074025;9536;9618.422894626345;9619.663311784054;4127.463429754112;4483.798229079699;4691.718496890129;4693.084848454519;4693.906121877543;5432.185172224198;5543.085390910535;5551.2228288039705;5554.694491802989;5562.360328562268;1219.0795949058404;1236.783562876493;1250.856151542566;1254.4166962362362;1256.5727652598162;698.3191388396273;710.9573425594481;725.4595326481699;735.569691730333;791.6081539637917;12851.01238441138;13755.38100785467;13938.303084845717;13980.091294065853;14042.578722638336;698.5564166754046;709.3970125393374;710.4706993290032;727.1782885339638;730.441212472459;5673.489385955201;5678.77284908599;5793.768249269982;5814.775363112393;5878.088896221093;129972.3501382487;132475.33762331126;133033;133674.33162834123;136960;118639.40680296543;119131;119540;122639.38680306541;123760;99711.50144249233;100062.49968750255;103370;103676.48161759143;105164;11142.72143196394;11266.94366528162;11554.59558915434;11604;11631.941840291083;49080.50919490902;50254.246186306504;50274.74862625664;50753.746231268604;51725.48274517357;62140.37859621346;62561.68719156557;62833;63567.6821615889;64480.67759661172;15492.767608486107;15665.451709190123;15686.607834804221;15789.289481973568;15844.049357038615;17941.102944852442;18259;18293.634127317113;18385.356512521998;18541.721874172166;16117.194140292704;16207.270672819515;16208.51374458768;16305.755413669041;16340.019598824108;17112.65774684524;17364.131793410532;17402.912985434992;17413.39053133185;17554;16910.57723556921;17226.655466890843;17266.136693165543;17491.38780142689;17520.912395437943;11937.104717146423;11940.582079627171;12017.158798884344;12055.939720301343;12065.638030858738;14987.625309367353;15872.76190857115;15970.520884373487;16076;16421.096839673934 19:43:54 INFO - PID 7109 | __end_tp_report 19:43:54 INFO - PID 7109 | __start_cc_report 19:43:54 INFO - PID 7109 | _x_x_mozilla_cycle_collect,280 19:43:54 INFO - PID 7109 | __end_cc_report 19:43:54 INFO - PID 7109 | __startTimestamp1503542634356__endTimestamp 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | ------- Summary: start ------- 19:43:54 INFO - PID 7109 | Number of tests: 6 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#0] dojo.html Cycles:165 Average:6437.61 Median:6802.18 stddev:822.68 (12.1%) stddev-sans-first:793.97 19:43:54 INFO - PID 7109 | Values: 3575.2 3616.4 3620.6 3631.9 3640.2 6417.8 6484.3 6514.3 6538.5 6539.4 6465.1 6507.7 6507.8 6550.2 6576.5 5557.6 5600.4 5613.2 5659.6 5669.7 5656.4 5683.9 5685.5 5688.5 5695.2 5619.9 5669.8 5702.4 5712.2 5740.8 5549.0 5603.2 5623.7 5672.0 5675.5 5623.7 5656.4 5685.9 5689.5 5701.8 6362.0 6378.0 6397.3 6441.8 6508.4 6805.3 6925.2 6930.4 6950.2 7043.8 7049.2 7064.3 7065.5 7068.1 7099.8 6478.5 6490.8 6525.7 6566.7 6568.1 7044.3 7117.8 7122.2 7124.1 7170.7 6892.0 6901.8 6933.7 6937.3 6940.2 6996.5 7042.8 7070.3 7074.3 7113.5 6802.2 6819.2 6872.9 6920.9 6922.3 6959.2 6988.7 7007.5 7008.7 7036.8 5046.7 5131.9 5137.8 5139.5 5168.9 4545.1 4601.8 4614.4 4619.2 4639.8 6433.3 6568.3 6569.2 6574.2 6592.6 7004.5 7065.6 7071.5 7082.3 7114.2 6626.7 6628.0 6677.7 6717.0 6724.1 5869.0 5881.6 5933.6 5952.4 5953.1 7048.4 7168.0 7185.0 7257.1 7269.2 7009.3 7062.0 7080.8 7088.4 7095.3 7211.1 7218.2 7223.1 7280.5 7304.7 6876.3 6889.2 6935.3 6960.3 6968.0 6932.1 7002.7 7050.7 7094.5 7134.8 6772.6 6854.8 6856.1 6856.7 6866.0 6768.5 6906.0 6924.2 6927.1 6933.0 6840.8 6846.3 6854.8 6915.8 6926.9 6866.9 6912.2 6917.1 6949.0 6976.1 6620.6 6629.4 6663.3 6703.1 6729.3 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#1] ext.html Cycles:180 Average:44145.96 Median:38436.02 stddev:67124.67 (174.6%) stddev-sans-first:67234.54 19:43:54 INFO - PID 7109 | Values: 931.8 939.1 968.1 984.4 990.9 37506.6 38342.2 45941.5 46418.5 46465.0 47233.3 47396.5 47531.0 47556.0 47742.5 7868.6 7885.8 7959.2 8025.2 8043.0 7924.6 7997.8 8041.6 8049.1 8049.6 8000.4 8008.9 8077.2 8098.7 8105.4 8018.6 8020.1 8034.7 8039.7 8064.4 7897.2 7952.7 7957.1 7971.6 7995.6 41517.8 41696.8 42046.6 42116.2 42383.4 3679.9 3709.6 3717.7 3718.3 3721.6 33732.0 33763.3 33774.7 33816.5 33858.2 5216.5 5248.7 5260.2 5262.2 5296.2 211603.0 214112.9 214515.0 214838.0 216264.0 52444.5 52872.0 52937.7 52986.0 52991.0 55011.4 55365.2 55389.2 55727.4 55781.7 14383.9 14557.1 14673.6 14698.7 14818.3 9831.0 10106.9 11522.9 11546.0 11558.4 16212.1 16295.6 16393.3 16396.3 16488.5 6020.9 6044.7 6101.5 6153.7 6164.5 1117.4 1130.5 1132.3 1133.8 1134.2 26785.6 27003.7 27043.0 27055.3 27442.6 1213.0 1224.5 1232.8 1242.6 1252.4 13706.0 13805.4 13922.4 14040.2 14178.4 296088.0 297315.0 297722.0 298002.0 298197.0 59943.4 60193.0 60383.4 60426.4 60507.1 1540.6 1544.5 1558.5 1598.6 1599.9 25395.0 25419.2 25525.7 25529.6 25782.6 41617.6 41794.6 41950.4 41958.0 41982.6 250789.0 254918.0 255311.0 255636.0 256045.0 38529.8 39414.6 41543.0 41626.2 41816.2 51439.7 52999.5 53022.2 53189.7 53306.5 37371.8 37697.8 37794.6 37901.6 38065.0 37380.6 37534.6 37650.8 37702.0 37883.4 43433.3 45053.5 45148.3 45350.0 45489.8 36827.8 37245.3 37268.9 37363.8 37451.0 26803.9 26964.3 27141.6 27148.2 27266.0 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#2] jquery.html Cycles:180 Average:40248.61 Median:2364.91 stddev:103151.43 (4361.7%) stddev-sans-first:103397.74 19:43:54 INFO - PID 7109 | Values: 556.4 563.9 565.9 571.9 583.6 23550.6 24535.6 24553.9 24579.6 24599.5 24906.1 24992.8 25286.4 25294.1 25464.6 6466.4 6581.2 6594.4 6626.4 6633.5 6222.0 6429.9 6437.7 6440.9 6441.1 6417.3 6417.9 6423.6 6424.3 6426.0 6386.8 6435.6 6436.8 6438.6 6445.9 5802.8 5875.5 5892.3 5910.8 5930.6 30749.0 31894.2 31983.5 32368.2 32460.5 2319.9 2361.4 2364.5 2365.3 2366.9 20320.3 20815.5 20908.6 20986.0 20988.2 2410.4 2466.3 2514.3 2514.5 2531.7 161880.0 162604.2 165168.2 165675.0 168919.0 14765.2 14946.6 15637.9 15676.7 15737.4 23386.8 23445.1 23505.1 23565.1 23628.3 9868.4 9884.3 9935.5 9960.1 9992.2 7785.5 8839.3 8858.2 8928.2 8979.3 8516.7 9580.2 9746.4 9786.2 10035.7 2665.8 2667.7 2729.2 2760.8 2780.7 1057.6 1081.5 1092.2 1093.1 1096.7 21492.2 21733.1 21733.8 22026.3 22104.6 1112.0 1124.1 1128.4 1134.4 1140.5 11696.4 12142.6 12192.1 12216.3 12246.2 590456.0 595959.0 618471.0 631736.0 631810.0 128310.0 129745.0 129808.0 132576.0 133565.3 1269.9 1283.3 1295.1 1301.0 1309.6 18970.4 19114.4 19343.7 19523.3 19596.8 61538.4 62341.7 62448.7 62966.0 63845.7 80962.0 81436.0 81951.0 82237.6 82654.6 14487.3 14732.2 14740.3 14769.8 14860.7 23540.8 23662.9 23732.3 23855.9 24889.0 18308.7 18573.5 19813.4 20024.9 20191.8 17245.2 17352.7 17367.7 17698.5 17856.3 19038.3 19319.3 19395.3 19416.3 19533.9 14752.6 14757.3 14761.6 14789.3 14829.6 19398.8 19602.3 19714.9 19768.9 19824.4 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#3] mootools.html Cycles:180 Average:10145.13 Median:23923.90 stddev:7171.88 (30.0%) stddev-sans-first:7162.26 19:43:54 INFO - PID 7109 | Values: 1453.5 1490.1 1496.1 1511.2 1524.5 15624.0 16156.2 16178.0 16182.4 16225.8 15938.8 17036.6 17082.5 17094.0 17095.7 3007.8 3041.2 3084.8 3085.4 3087.2 2950.7 2979.0 2987.7 3052.1 3055.8 2995.2 3015.7 3040.3 3058.1 3064.6 2921.1 2928.3 2936.1 2944.8 2951.5 2936.6 2946.4 2957.2 2958.7 2964.9 15793.4 15839.9 16066.6 16082.1 16084.8 8616.7 8905.2 8924.1 8953.5 8956.8 5512.0 5537.0 5564.4 5707.4 5755.3 1799.1 1826.3 1859.2 1882.1 1883.6 28385.3 28411.6 28490.7 28588.9 28648.9 7210.7 7436.6 7479.4 7573.1 7639.2 19084.1 19180.2 19231.3 19261.7 19265.1 8319.9 8569.5 8582.6 8598.3 8605.3 7804.1 7851.6 7915.8 8116.6 8130.5 5489.8 5786.1 5902.6 5947.9 6031.8 1621.5 1705.1 1751.9 1762.6 1792.6 991.1 996.4 999.7 1005.8 1020.8 8571.8 8607.4 8621.4 8658.7 8726.2 1036.8 1060.5 1062.5 1064.0 1081.1 6006.2 6123.4 6607.5 6737.7 6751.9 22190.2 23001.4 23391.0 23907.2 23940.6 22672.0 22719.5 22777.3 23033.7 23057.3 11782.9 12063.9 12344.5 12379.8 12429.6 9445.8 9532.9 9669.6 9674.0 9693.2 19649.9 20340.1 20387.5 20519.3 20825.0 20546.3 20567.9 20828.4 20834.7 20904.5 13569.0 13650.9 13667.2 13693.7 13698.0 12926.4 14837.7 15074.4 15217.9 15223.4 10089.4 11482.7 11565.2 11714.0 11770.6 11520.5 11649.8 11662.9 11790.9 11907.7 10152.0 10206.9 10217.5 10320.6 10323.0 7939.6 8069.4 8193.0 8200.0 8205.7 8267.6 8360.0 8407.8 8460.7 8483.1 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#4] prototype.html Cycles:180 Average:5650.42 Median:6327.73 stddev:1560.13 (24.7%) stddev-sans-first:1516.05 19:43:54 INFO - PID 7109 | Values: 509.9 510.4 532.8 537.6 545.4 6185.9 6224.7 6332.7 6333.9 6335.5 6163.8 6186.4 6186.8 6230.0 6261.0 4948.5 4968.3 4986.8 4988.7 5036.3 4766.0 4845.5 4945.6 4977.2 4999.2 4810.7 4834.9 4837.6 4847.2 4859.7 4841.3 4841.4 4854.9 4866.3 4869.2 4361.3 4369.9 4373.5 4374.5 4375.7 5967.4 5990.2 6017.9 6077.4 6119.9 5771.9 5777.2 5819.7 5824.2 5865.3 6425.8 6487.3 6610.7 6625.7 6645.1 4907.7 4943.4 4960.0 4962.8 4966.1 6705.3 6783.3 6877.3 6885.7 6943.6 5451.2 5452.6 5475.5 5488.3 5503.8 5540.3 5590.4 5608.7 5611.2 5625.9 5916.3 5933.9 5942.5 5985.4 6004.9 6544.8 6563.3 6597.6 6648.5 6652.0 1948.9 1953.3 1960.8 1966.1 1974.2 1390.0 1461.4 1461.8 1462.9 1464.0 6322.7 6353.2 6380.3 6406.5 6458.4 6639.7 6702.4 6734.8 6748.4 6764.8 6243.6 6303.0 6309.9 6368.9 6436.6 3611.8 3616.4 3621.9 3626.8 3649.9 6965.8 6976.4 7029.1 7048.7 7053.2 6904.6 6943.9 6993.2 7014.7 7019.5 6874.2 6957.2 6988.2 6997.7 7046.8 6708.7 6757.9 6773.2 6818.6 6848.6 6708.7 6738.6 6755.7 6758.7 6761.0 6862.1 6893.2 6942.9 6987.7 6997.4 5279.6 5291.2 5303.2 5323.9 5356.9 6545.6 6620.4 6691.6 6732.9 6741.8 6447.6 6492.3 6542.4 6561.3 6607.6 6434.3 6563.7 6569.8 6587.9 6605.5 6371.6 6493.7 6509.8 6574.4 6590.6 6566.0 6583.3 6725.9 6733.3 6739.5 6402.6 6506.9 6516.6 6519.1 6519.7 19:43:54 INFO - PID 7109 | 19:43:54 INFO - PID 7109 | [#5] yui.html Cycles:180 Average:25915.39 Median:17620.96 stddev:37583.49 (213.3%) stddev-sans-first:37642.16 19:43:54 INFO - PID 7109 | Values: 946.6 960.8 971.9 991.2 993.4 18681.3 19691.9 20319.2 20341.2 20845.4 19691.4 19845.8 20119.5 20168.3 20172.5 863.7 878.0 1079.7 1081.3 1085.9 1090.3 1094.6 1096.0 1096.3 1097.9 1144.5 1149.9 1151.6 1151.9 1157.5 1141.0 1142.1 1142.3 1145.5 1147.8 848.1 850.1 850.6 850.9 851.5 17788.8 17928.0 18669.3 20562.7 20842.8 20865.3 20977.4 21036.2 21270.0 21827.3 16832.4 16917.9 17088.3 17264.7 17489.2 3712.1 3750.5 3751.4 3752.7 3756.0 137559.0 140005.3 141914.0 141998.0 142274.0 16870.7 17437.2 17485.4 17539.3 17687.9 30610.5 31907.4 32000.2 32206.0 32254.2 8454.2 9217.9 9536.0 9618.4 9619.7 4127.5 4483.8 4691.7 4693.1 4693.9 5432.2 5543.1 5551.2 5554.7 5562.4 1219.1 1236.8 1250.9 1254.4 1256.6 698.3 711.0 725.5 735.6 791.6 12851.0 13755.4 13938.3 13980.1 14042.6 698.6 709.4 710.5 727.2 730.4 5673.5 5678.8 5793.8 5814.8 5878.1 129972.4 132475.3 133033.0 133674.3 136960.0 118639.4 119131.0 119540.0 122639.4 123760.0 99711.5 100062.5 103370.0 103676.5 105164.0 11142.7 11266.9 11554.6 11604.0 11631.9 49080.5 50254.2 50274.7 50753.7 51725.5 62140.4 62561.7 62833.0 63567.7 64480.7 15492.8 15665.5 15686.6 15789.3 15844.0 17941.1 18259.0 18293.6 18385.4 18541.7 16117.2 16207.3 16208.5 16305.8 16340.0 17112.7 17364.1 17402.9 17413.4 17554.0 16910.6 17226.7 17266.1 17491.4 17520.9 11937.1 11940.6 12017.2 12055.9 12065.6 14987.6 15872.8 15970.5 16076.0 16421.1 19:43:54 INFO - PID 7109 | -------- Summary: end -------- 19:43:54 INFO - PID 7109 | 19:43:55 INFO - TEST-INFO | 7109: exit 0 19:43:55 INFO - TEST-OK | dromaeo_css | took 1109256ms 19:43:55 INFO - TEST-START | kraken 19:43:55 INFO - Initialising browser for kraken test... 19:43:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59516/getInfo.html -profile /tmp/tmpiIJiiS/profile 19:43:55 INFO - TEST-INFO | started process 7469 (/builds/slave/test/build/application/firefox/firefox http://localhost:59516/getInfo.html) 19:44:00 INFO - TEST-INFO | 7469: exit 0 19:44:00 INFO - Browser initialized. 19:44:00 INFO - Running cycle 1/1 for kraken test... 19:44:00 INFO - TEST-INFO | started process 7633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiIJiiS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:44:01 INFO - PID 7633 | 1503542641289 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:44:12 INFO - PID 7633 | RSS: Main: 150941696 19:44:12 INFO - PID 7633 | 19:44:14 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59516/tests/kraken/driver.html?testName=audio-beat-detection) 19:44:15 INFO - PID 7633 | RSS: Main: 157519872 19:44:15 INFO - PID 7633 | 19:44:18 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59516/tests/kraken/driver.html?testName=audio-dft) 19:44:18 INFO - PID 7633 | RSS: Main: 158195712 19:44:18 INFO - PID 7633 | 19:44:21 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59516/tests/kraken/driver.html?testName=audio-fft) 19:44:22 INFO - PID 7633 | RSS: Main: 158105600 19:44:22 INFO - PID 7633 | 19:44:24 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59516/tests/kraken/driver.html?testName=audio-oscillator) 19:44:24 INFO - PID 7633 | RSS: Main: 158179328 19:44:24 INFO - PID 7633 | 19:44:26 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:44:27 INFO - PID 7633 | RSS: Main: 158560256 19:44:27 INFO - PID 7633 | 19:44:30 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59516/tests/kraken/driver.html?testName=imaging-darkroom) 19:44:31 INFO - PID 7633 | RSS: Main: 158527488 19:44:31 INFO - PID 7633 | 19:44:34 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59516/tests/kraken/driver.html?testName=imaging-desaturate) 19:44:35 INFO - PID 7633 | RSS: Main: 160882688 19:44:35 INFO - PID 7633 | 19:44:37 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59516/tests/kraken/driver.html?testName=json-parse-financial) 19:44:38 INFO - PID 7633 | RSS: Main: 161759232 19:44:38 INFO - PID 7633 | 19:44:40 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:44:40 INFO - PID 7633 | RSS: Main: 162365440 19:44:40 INFO - PID 7633 | 19:44:42 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:44:43 INFO - PID 7633 | RSS: Main: 162123776 19:44:43 INFO - PID 7633 | 19:44:45 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:44:45 INFO - PID 7633 | RSS: Main: 162119680 19:44:45 INFO - PID 7633 | 19:44:48 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:44:48 INFO - PID 7633 | RSS: Main: 162205696 19:44:48 INFO - PID 7633 | 19:44:51 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:44:52 INFO - PID 7633 | RSS: Main: 162422784 19:44:52 INFO - PID 7633 | 19:44:53 INFO - PID 7633 | Cycle 1(1): loaded http://localhost:59516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59516/tests/kraken/driver.html?testName=ai-astar) 19:44:54 INFO - PID 7633 | RSS: Main: 163516416 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | __start_tp_report 19:44:54 INFO - PID 7633 | _x_x_mozilla_page_load 19:44:54 INFO - PID 7633 | _x_x_mozilla_page_load_details 19:44:54 INFO - PID 7633 | |i|pagename|runs| 19:44:54 INFO - PID 7633 | |0;ai-astar;96;109;98;105;105;112;107;99;106;109 19:44:54 INFO - PID 7633 | |1;audio-beat-detection;135;111;138;175;115;141;140;113;172;120 19:44:54 INFO - PID 7633 | |2;audio-dft;162;163;161;161;161;164;162;163;162;160 19:44:54 INFO - PID 7633 | |3;audio-fft;75;75;74;189;76;74;87;75;159;76 19:44:54 INFO - PID 7633 | |4;audio-oscillator;78;78;139;77;78;78;137;79;77;120 19:44:54 INFO - PID 7633 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;117;114 19:44:54 INFO - PID 7633 | |6;imaging-darkroom;147;147;148;147;148;148;148;148;149;147 19:44:54 INFO - PID 7633 | |7;imaging-desaturate;94;94;94;94;95;94;94;94;94;94 19:44:54 INFO - PID 7633 | |8;json-parse-financial;50;52;47;47;49;49;48;47;48;47 19:44:54 INFO - PID 7633 | |9;json-stringify-tinderbox;52;51;52;52;52;52;52;52;52;52 19:44:54 INFO - PID 7633 | |10;stanford-crypto-aes;75;74;79;80;80;72;74;74;72;74 19:44:54 INFO - PID 7633 | |11;stanford-crypto-ccm;118;125;124;116;117;113;114;114;118;140 19:44:54 INFO - PID 7633 | |12;stanford-crypto-pbkdf2;174;171;160;163;162;172;171;158;156;159 19:44:54 INFO - PID 7633 | |13;stanford-crypto-sha256-iterative;60;61;60;60;63;68;63;60;60;57 19:44:54 INFO - PID 7633 | __end_tp_report 19:44:54 INFO - PID 7633 | __start_cc_report 19:44:54 INFO - PID 7633 | _x_x_mozilla_cycle_collect,781 19:44:54 INFO - PID 7633 | __end_cc_report 19:44:54 INFO - PID 7633 | __startTimestamp1503542694230__endTimestamp 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | ------- Summary: start ------- 19:44:54 INFO - PID 7633 | Number of tests: 14 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#0] ai-astar Cycles:10 Average:104.60 Median:110.50 stddev:5.27 (4.8%) stddev-sans-first:4.59 19:44:54 INFO - PID 7633 | Values: 96.0 109.0 98.0 105.0 105.0 112.0 107.0 99.0 106.0 109.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:139.00 stddev:22.89 (16.5%) stddev-sans-first:24.27 19:44:54 INFO - PID 7633 | Values: 135.0 111.0 138.0 175.0 115.0 141.0 140.0 113.0 172.0 120.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 19:44:54 INFO - PID 7633 | Values: 162.0 163.0 161.0 161.0 161.0 164.0 162.0 163.0 162.0 160.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.00 stddev:41.89 (55.8%) stddev-sans-first:43.73 19:44:54 INFO - PID 7633 | Values: 75.0 75.0 74.0 189.0 76.0 74.0 87.0 75.0 159.0 76.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.00 stddev:26.62 (34.1%) stddev-sans-first:27.59 19:44:54 INFO - PID 7633 | Values: 78.0 78.0 139.0 77.0 78.0 78.0 137.0 79.0 77.0 120.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 19:44:54 INFO - PID 7633 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 117.0 114.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:44:54 INFO - PID 7633 | Values: 147.0 147.0 148.0 147.0 148.0 148.0 148.0 148.0 149.0 147.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:44:54 INFO - PID 7633 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.50 stddev:1.65 (3.4%) stddev-sans-first:1.64 19:44:54 INFO - PID 7633 | Values: 50.0 52.0 47.0 47.0 49.0 49.0 48.0 47.0 48.0 47.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#9] json-stringify-tinderbox Cycles:10 Average:51.90 Median:52.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 19:44:54 INFO - PID 7633 | Values: 52.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.50 stddev:3.10 (4.2%) stddev-sans-first:3.28 19:44:54 INFO - PID 7633 | Values: 75.0 74.0 79.0 80.0 80.0 72.0 74.0 74.0 72.0 74.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:118.00 stddev:8.13 (6.9%) stddev-sans-first:8.59 19:44:54 INFO - PID 7633 | Values: 118.0 125.0 124.0 116.0 117.0 113.0 114.0 114.0 118.0 140.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:167.00 stddev:6.70 (4.0%) stddev-sans-first:6.19 19:44:54 INFO - PID 7633 | Values: 174.0 171.0 160.0 163.0 162.0 172.0 171.0 158.0 156.0 159.0 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:60.50 stddev:2.94 (4.9%) stddev-sans-first:3.08 19:44:54 INFO - PID 7633 | Values: 60.0 61.0 60.0 60.0 63.0 68.0 63.0 60.0 60.0 57.0 19:44:54 INFO - PID 7633 | -------- Summary: end -------- 19:44:54 INFO - PID 7633 | 19:44:54 INFO - PID 7633 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:44:54 INFO - TEST-INFO | 7633: exit 0 19:44:54 INFO - TEST-OK | kraken | took 59888ms 19:44:54 INFO - SUITE-END | took 1169s 19:44:55 INFO - Completed test suite (00:19:29) 19:44:55 INFO - javascript benchmark 19:44:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9056.858818094448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3575.1598374382, 3616.4213725803875, 3620.601733809279, 3631.854725810968, 3640.199156185639, 6417.839554011152, 6484.2867284598715, 6514.283428822826, 6538.542302038859, 6539.378759017892, 6465.094886715863, 6507.739690412378, 6507.8373040674005, 6550.181227346582, 6576.506761992846, 5557.638753481011, 5600.411956744544, 5613.186088017235, 5659.60382773206, 5669.744861481243, 5656.377798442189, 5683.914741278863, 5685.545156387499, 5688.516476099537, 5695.202671625955, 5619.859503512404, 5669.801556945507, 5702.429757024285, 5712.171735098408, 5740.827775166731, 5548.9722551386985, 5603.2435621191025, 5623.662580245157, 5672.0, 5675.5459563234845, 5623.718814059322, 5656.377798442168, 5685.943140568583, 5689.459501347365, 5701.771929122871, 6361.950278204091, 6377.968110159466, 6397.264314603787, 6441.83895402614, 6508.446782023534, 6805.251422343587, 6925.238223795379, 6930.410915072174, 6950.165980082423, 7043.753468628624, 7049.154101507801, 7064.293570642946, 7065.505414620979, 7068.11648543932, 7099.787006389816, 6478.481721462272, 6490.8052758417325, 6525.738970441224, 6566.70449829754, 6568.080468734381, 7044.260352662999, 7117.822054448577, 7122.18094919091, 7124.145102587619, 7170.749023784142, 6892.0, 6901.827454313682, 6933.722651094001, 6937.306269373023, 6940.236573976858, 6996.475264355194, 7042.753503627348, 7070.292970702889, 7074.257202993612, 7113.502054856111, 6802.183737951477, 6819.181698196248, 6872.896906546406, 6920.861582768316, 6922.2731613180895, 6959.234484206733, 6988.6855091521, 7007.509474336849, 7008.719651213996, 7036.788896333118, 5046.747662616928, 5131.871703207375, 5137.794488220504, 5139.537441630271, 5168.896622067613, 4545.0909818036525, 4601.7699115044115, 4614.423197100363, 4619.168549661026, 4639.791209395586, 6433.324500927429, 6568.310327415648, 6569.24453687832, 6574.211094668574, 6592.637404942774, 7004.544704594185, 7065.576065435987, 7071.504994650325, 7082.256363081905, 7114.217436082027, 6626.7017984190825, 6628.0, 6677.732890684415, 6716.966415167893, 6724.058631791553, 5869.0, 5881.647101173943, 5933.614315069507, 5952.375000624958, 5953.1070339449425, 7048.365647091787, 7167.960645706447, 7184.964075179695, 7257.092863392076, 7269.20038795732, 7009.334113259232, 7062.0, 7080.752173674103, 7088.362047415551, 7095.325944035309, 7211.098612673416, 7218.242084581043, 7223.061002069698, 7280.490365674564, 7304.671289792079, 6876.312368763083, 6889.2421833599265, 6935.3411425914455, 6960.303969603202, 6968.0, 6932.064171337007, 7002.684879180347, 7050.682719277543, 7094.53885497441, 7134.821629459305, 6772.627505487246, 6854.760083397057, 6856.108705868205, 6856.657167141722, 6866.004429357815, 6768.492363072691, 6905.964105384232, 6924.238333783381, 6927.099477067949, 6932.994715766286, 6840.7605733801065, 6846.349596788297, 6854.828629284308, 6915.827104322432, 6926.896096558455, 6866.862662746617, 6912.205096413977, 6917.100776898971, 6948.992396102638, 6976.058232138596, 6620.569662971891, 6629.403353698191, 6663.300353462817, 6703.128593282842, 6729.2934241903895], "value": 6375.101485196948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.785689291463, 939.1125386509747, 968.1238479176343, 984.3650845204843, 990.9108180263775, 37506.62493375065, 38342.23315533688, 45941.540584594186, 46418.535814641844, 46465.0, 47233.29150062752, 47396.52603473973, 47531.0, 47556.0, 47742.522574774244, 7868.567228802413, 7885.8028549286155, 7959.243871832166, 8025.197480251957, 8043.03483581971, 7924.603769811515, 7997.7600671979935, 8041.597920104001, 8049.114597394282, 8049.557274349909, 8000.439969202158, 8008.879866802003, 8077.192280771935, 8098.716544920929, 8105.392095592824, 8018.639161237758, 8020.077691065544, 8034.718784842532, 8039.678412863537, 8064.354851611857, 7897.24976127267, 7952.681892724342, 7957.084935232407, 7971.641276142587, 7995.600219988977, 41517.79241103775, 41696.791516042525, 42046.579534204575, 42116.1576768466, 42383.36424953628, 3679.9448008279896, 3709.5919448860604, 3717.6654101130757, 3718.3307004739136, 3721.6464435878547, 33732.0, 33763.32473350544, 33774.6622533774, 33816.492752608734, 33858.153546161295, 5216.504432078947, 5248.6588371755715, 5260.1583746600745, 5262.158054711228, 5296.205569164617, 211603.0, 214112.92943535338, 214515.0, 214838.0, 216264.0, 52444.475555244724, 52872.0, 52937.735311323195, 52986.0, 52991.0, 55011.44988550063, 55365.169522457196, 55389.1691624626, 55727.442725572226, 55781.72109139428, 14383.856161438462, 14557.12657240569, 14673.559793206008, 14698.706025879423, 14818.259087045604, 9831.0, 10106.898931010743, 11522.884771152349, 11546.0, 11558.422078896021, 16212.108334041504, 16295.592610184603, 16393.262303196385, 16396.344146234256, 16488.505344839676, 6020.909686354708, 6044.727987240584, 6101.542384321194, 6153.7230824613, 6164.537659675542, 1117.407773879845, 1130.4799792095564, 1132.2640283815422, 1133.7619099989095, 1134.2287244673537, 26785.598216026774, 27003.729962700516, 27043.0, 27055.323616909736, 27442.5883611746, 1212.9696757580955, 1224.5285565057518, 1232.8027515597462, 1242.577523641966, 1252.3612957391613, 13706.0, 13805.378757955916, 13922.373493192628, 14040.227787471584, 14178.361973711208, 296088.0, 297315.0, 297722.0, 298002.0, 298197.0, 59943.40056599378, 60193.0, 60383.396166038656, 60426.395736042956, 60507.09239361413, 1540.6225474758755, 1544.5289186798134, 1558.5168597734964, 1598.6243232840272, 1599.88800783944, 25395.0, 25419.237422877344, 25525.74474255308, 25529.617055743805, 25782.61326080073, 41617.58382416137, 41794.58205417907, 41950.37074443947, 41958.0, 41982.58017419909, 250789.0, 254918.0, 255311.0, 255636.0, 256045.0, 38529.80735096306, 39414.605853941095, 41543.0, 41626.1674766509, 41816.163676725686, 51439.742801285756, 52999.47000529945, 53022.204666929254, 53189.7340513295, 53306.46693533015, 37371.81314093412, 37697.81151094227, 37794.62205377911, 37901.620983789806, 38065.0, 37380.626193738804, 37534.62465375311, 37650.81174594109, 37702.0, 37883.431748524345, 43433.3484997719, 45053.54946450625, 45148.32277515905, 45350.0, 45489.772551138354, 36827.81586092053, 37245.25509489741, 37268.881933542034, 37363.813180933925, 37451.0, 26803.865980669972, 26964.32589185286, 27141.59287610648, 27148.1855544334, 27266.0], "value": 18951.779308939265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4268803132773, 563.8618538458078, 565.9066254068078, 571.8513186571492, 583.588570058109, 23550.64674029889, 24535.63196552053, 24553.877230613867, 24579.63130553043, 24599.508009839792, 24906.12828551001, 24992.750072499315, 25286.36784080399, 25294.114705985296, 25464.618030729554, 6466.35336466352, 6581.177352830896, 6594.4065034146915, 6626.370494802986, 6633.535652504326, 6222.0, 6429.935700643004, 6437.6781160942, 6440.903386449207, 6441.0982462455295, 6417.326180751024, 6417.935820641804, 6423.550351475398, 6424.293327733945, 6426.036094585803, 6386.808395748135, 6435.6138631682015, 6436.839079023015, 6438.581492203015, 6445.903311450332, 5802.767889284423, 5875.529957603381, 5892.322382925932, 5910.7931222407005, 5930.644161350289, 30749.0, 31894.20264493383, 31983.52024719631, 32368.190795230308, 32460.513092303634, 2319.9420014499606, 2361.409647588103, 2364.5270945810908, 2365.3022358404314, 2366.8934897929635, 20320.28878989243, 20815.479613009644, 20908.58182836335, 20985.950702464816, 20988.16047358104, 2410.433548116191, 2466.2971053249917, 2514.270861450177, 2514.4719608882156, 2531.734167912361, 161880.0, 162604.18697906553, 165168.17415912964, 165675.0, 168919.0, 14765.187914664582, 14946.587225881944, 15637.921810390875, 15676.68646627084, 15737.44918927832, 23386.7661323388, 23445.06219751191, 23505.059797608246, 23565.057397704244, 23628.29115126549, 9868.407895526292, 9884.25868059884, 9935.453550054672, 9960.111567645446, 9992.150667193224, 7785.532868027936, 8839.337049721296, 8858.202761751474, 8928.241099506615, 8979.281657467387, 8516.74449766508, 9580.18568421678, 9746.415215087118, 9786.217102631772, 10035.749106272255, 2665.7867370610306, 2667.7465640764094, 2729.19488750819, 2760.7791376689815, 2780.708025657317, 1057.603398725478, 1081.4592703648175, 1092.224520590374, 1093.1254996003165, 1096.6819622309602, 21492.24777132793, 21733.130674773147, 21733.782662173493, 22026.33920982373, 22104.557908841733, 1111.9777604448027, 1124.0951034417374, 1128.3568366031448, 1134.4384529657873, 1140.5494829542283, 11696.415179241174, 12142.575009874612, 12192.146549741434, 12216.328101954477, 12246.203996740362, 590456.0, 595959.0, 618471.0, 631736.0, 631810.0, 128310.0, 129745.0, 129808.0, 132576.0, 133565.33217334046, 1269.9301538415475, 1283.3006011723633, 1295.1257900916844, 1301.0372324479818, 1309.6071178646368, 18970.43088707341, 19114.426567203005, 19343.709844352066, 19523.316683915993, 19596.8040319595, 61538.384616153264, 62341.688291560065, 62448.687756560925, 62966.0, 63845.68077159584, 80962.0, 81436.0, 81951.0, 82237.58881205556, 82654.58672706598, 14487.348069336695, 14732.189729564549, 14740.336684848993, 14769.778453322993, 14860.702785944437, 23540.76459235386, 23662.881685591463, 23732.288031359087, 23855.880720596288, 24889.0, 18308.72536911974, 18573.535661608566, 19813.405597832087, 20024.899875501113, 20191.79808201958, 17245.22396492186, 17352.65294694074, 17367.739483908004, 17698.469045928643, 17856.285748569913, 19038.33365832189, 19319.323823666666, 19395.3211637592, 19416.320428784926, 19533.902330488258, 14752.55742327732, 14757.335919883417, 14761.630959226106, 14789.260536973323, 14829.555113346616, 19398.806011940265, 19602.313919012766, 19714.901425492782, 19768.901155494706, 19824.405267841412], "value": 12601.113953017253, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.498543002664, 1490.128274959149, 1496.1247670112984, 1511.1764088571726, 1524.5426372088375, 15624.0, 16156.192190390462, 16178.0, 16182.433614823483, 16225.75661365079, 15938.760918586231, 17036.574085647866, 17082.487525374258, 17094.0, 17095.74356384652, 3007.7894547381693, 3041.194083567845, 3084.768642351821, 3085.444619968405, 3087.1818967973504, 2950.7344339009483, 2979.0, 2987.671356150822, 3052.1453992881916, 3055.7860949733526, 2995.1912983494553, 3015.6682764895845, 3040.255137491318, 3058.1284333964823, 3064.5709600655928, 2921.0652591170942, 2928.2825707701536, 2936.1485169300877, 2944.764418846487, 2951.513000354939, 2936.559516072606, 2946.351802603424, 2957.1572101951056, 2958.689337619562, 2964.9407011859644, 15793.368265269375, 15839.920800395925, 16066.5983350416, 16082.115483648395, 16084.75872861908, 8616.741497755078, 8905.154010369004, 8924.107589241088, 8953.462792232422, 8956.820863582758, 5511.9724401378135, 5537.0, 5564.415736347706, 5707.429257074301, 5755.280589926259, 1799.1454059321848, 1826.269492203116, 1859.237712537853, 1882.124811962444, 1883.595027069173, 28385.290367740767, 28411.57382639262, 28490.715092848804, 28588.857055714798, 28648.85675571609, 7210.67551960163, 7436.628168591549, 7479.439042071866, 7573.091229052549, 7639.197884222188, 19084.14121364542, 19180.232790688497, 19231.326903558307, 19261.711074333896, 19265.13306901193, 8319.916800831914, 8569.528675922884, 8582.570871456403, 8598.312135029182, 8605.31157507398, 7804.063512378438, 7851.607419628996, 7915.841683166304, 8116.59417029158, 8130.512169269863, 5489.752961116759, 5786.132080188006, 5902.58681892272, 5947.910781338197, 6031.7587296507645, 1621.4649165775265, 1705.104819969501, 1751.8944096294545, 1762.5946032412617, 1792.6056267621102, 991.1377101921374, 996.3772642098688, 999.7350702063959, 1005.7787286796893, 1020.7805321855836, 8571.785705357292, 8607.397482176188, 8621.353398495012, 8658.653653853775, 8726.214640682241, 1036.8185567525652, 1060.4962642744788, 1062.516554967488, 1063.9787204255872, 1081.1350919264557, 6006.249218847644, 6123.418275263843, 6607.537472376887, 6737.663116844138, 6751.898721519181, 22190.223342183268, 23001.424964376023, 23391.0, 23907.16324928619, 23940.640890386658, 22672.0, 22719.545609087727, 22777.31668049961, 23033.654495182585, 23057.308280751604, 11782.882171178178, 12063.939680301717, 12344.506219751289, 12379.75240495185, 12429.627111186679, 9445.811083778424, 9532.85700714476, 9669.564869581027, 9674.0, 9693.176080033276, 19649.901750491157, 20340.084696188413, 20387.490312741706, 20519.281825136048, 20824.95875206264, 20546.28088016972, 20567.8971605147, 20828.375148745563, 20834.687479687513, 20904.47738806481, 13569.0, 13650.863491364958, 13667.17996920188, 13693.657658558615, 13698.0, 12926.35368231566, 14837.703245935238, 15074.397024118913, 15217.923910380377, 15223.391064357302, 10089.394636321844, 11482.655520334403, 11565.248258863146, 11714.0, 11770.646880593597, 11520.481578329163, 11649.825252621047, 11662.88337116618, 11790.941045295061, 11907.702307442383, 10152.0, 10206.948965255126, 10217.489125543842, 10320.638777642747, 10323.0, 7939.563324017235, 8069.3544516439715, 8193.0, 8199.95900020496, 8205.71280005197, 8267.62795674184, 8360.0, 8407.831843362976, 8460.703875364332, 8483.10927352619], "value": 7294.458111704747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.9469595285735, 510.44616590998766, 532.8241680245519, 537.5914305128107, 545.42457707119, 6185.876282474348, 6224.657643829593, 6332.746690132395, 6333.873322533553, 6335.461485773715, 6163.753449862, 6186.350433204516, 6186.84532886677, 6230.0, 6260.968695156518, 4948.455669876311, 4968.267452900908, 4986.825461108862, 4988.65079444439, 5036.269740887569, 4766.0, 4845.466998630148, 4945.604351651859, 4977.178765503688, 4999.225120106389, 4810.735409552473, 4834.936314010912, 4837.637177211705, 4847.175980083394, 4859.73271470069, 4841.346418233528, 4841.419029716421, 4854.854354369375, 4866.343043689109, 4869.172240719051, 4361.302191649353, 4369.868903932887, 4373.453318335208, 4374.49693285273, 4375.7374557526655, 5967.403259673998, 5990.2212712347555, 6017.939820601781, 6077.359113039454, 6119.908201376983, 5771.942280577183, 5777.19119323295, 5819.7090145492975, 5824.184614154022, 5865.296164460249, 6425.815222824215, 6487.286398496161, 6610.669466526654, 6625.701843417058, 6645.136132302818, 4907.730074845882, 4943.382077240345, 4959.975200123977, 4962.826301079481, 4966.1309270877455, 6705.329467053304, 6783.3216678332265, 6877.312268773083, 6885.655717214169, 6943.583384996816, 5451.182322651554, 5452.618316717871, 5475.4524547545725, 5488.341399032061, 5503.798910029983, 5540.335159780852, 5590.357108932443, 5608.719564021782, 5611.186377975171, 5625.859353516113, 5916.26046744157, 5933.851653708692, 5942.494887934487, 5985.431384018511, 6004.939950600526, 6544.803655890331, 6563.343665633399, 6597.571157874723, 6648.501362397839, 6652.0, 1948.908611177745, 1953.2870502266571, 1960.7549056367955, 1966.0857701169025, 1974.220183027696, 1389.9513517026855, 1461.4008256614736, 1461.8099647046029, 1462.8610282023192, 1463.9560813175622, 6322.71547780351, 6353.174087368612, 6380.298167201604, 6406.487481001509, 6458.354164583598, 6639.701213445406, 6702.36327548882, 6734.764283250062, 6748.358905903931, 6764.83087922796, 6243.594166379171, 6302.957633892867, 6309.873802524015, 6368.936310636835, 6436.581622194542, 3611.7652352597524, 3616.385214513539, 3621.8913432596537, 3626.7642603230706, 3649.872254471081, 6965.805771182061, 6976.372126508639, 7029.121359830021, 7048.682809273595, 7053.188883278386, 6904.620245886525, 6943.930560694429, 6993.195782484978, 7014.684339204748, 7019.508634395544, 6874.175098988154, 6957.199922008933, 6988.161420629455, 6997.720091196397, 7046.823829404306, 6708.664566771544, 6757.898631520433, 6773.221079575912, 6818.590884546943, 6848.554843935129, 6708.664566771739, 6738.561993470409, 6755.662216889037, 6758.7296508139125, 6761.0, 6862.073620061228, 6893.20728116253, 6942.854429019155, 6987.7204911802955, 6997.370236678723, 5279.6040296978645, 5291.23277124807, 5303.178007408857, 5323.893522129613, 5356.946430535801, 6545.607263564201, 6620.404163625297, 6691.5650482718465, 6732.932670673426, 6741.775214179407, 6447.615621377508, 6492.253390859923, 6542.411182993554, 6561.343865613591, 6607.6212563478075, 6434.260060092962, 6563.704633291609, 6569.835754105994, 6587.934120658923, 6605.5376123670885, 6371.566397560512, 6493.675316234264, 6509.804705858832, 6574.4411725002, 6590.5716128451495, 6566.0479230512265, 6583.30875258091, 6725.865482690221, 6733.259341472336, 6739.494537909774, 6402.647854368054, 6506.902396463962, 6516.641584712696, 6519.054737063194, 6519.674016299261], "value": 5206.882328727396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.6450081219539, 960.7982323712022, 971.9319647624665, 991.2218908157098, 993.4486360070158, 18681.252749890024, 19691.901540492294, 20319.1872325107, 20341.18635254588, 20845.374638760823, 19691.409257722255, 19845.801541984576, 20119.49701257469, 20168.294109706163, 20172.495687607818, 863.7322430046675, 877.9648814047431, 1079.6545105566183, 1081.2863510083346, 1085.8914108589117, 1090.2858627598935, 1094.5512339940626, 1096.0135877710045, 1096.3257596578087, 1097.8847221041794, 1144.5193018932068, 1149.9080073594093, 1151.5624062856102, 1151.9136064795173, 1157.5022740221702, 1141.0, 1142.1319796954292, 1142.2860712054965, 1145.4730823821053, 1147.822087576427, 848.1052489623445, 850.1328644782287, 850.553459433796, 850.8808766772656, 851.5188918261163, 17788.822111778845, 17928.0, 18669.25322987079, 20562.69155962662, 20842.791572084236, 20865.269715559883, 20977.37067887966, 21036.158553657835, 21270.0, 21827.345179644635, 16832.410865619768, 16917.915410422993, 17088.316467341414, 17264.654706905792, 17489.21298541569, 3712.1276500022473, 3750.5499340079364, 3751.4372844073337, 3752.7185461090253, 3755.962440375589, 137559.0, 140005.29997349947, 141914.0, 141998.0, 142274.0, 16870.662586748444, 17437.21532531039, 17485.388011419538, 17539.298428062735, 17687.91156044237, 30610.54084188739, 31907.36185276328, 32000.199995000312, 32206.0, 32254.19364515906, 8454.196851299117, 9217.861732074025, 9536.0, 9618.422894626345, 9619.663311784054, 4127.463429754112, 4483.798229079699, 4691.718496890129, 4693.084848454519, 4693.906121877543, 5432.185172224198, 5543.085390910535, 5551.2228288039705, 5554.694491802989, 5562.360328562268, 1219.0795949058404, 1236.783562876493, 1250.856151542566, 1254.4166962362362, 1256.5727652598162, 698.3191388396273, 710.9573425594481, 725.4595326481699, 735.569691730333, 791.6081539637917, 12851.01238441138, 13755.38100785467, 13938.303084845717, 13980.091294065853, 14042.578722638336, 698.5564166754046, 709.3970125393374, 710.4706993290032, 727.1782885339638, 730.441212472459, 5673.489385955201, 5678.77284908599, 5793.768249269982, 5814.775363112393, 5878.088896221093, 129972.3501382487, 132475.33762331126, 133033.0, 133674.33162834123, 136960.0, 118639.40680296543, 119131.0, 119540.0, 122639.38680306541, 123760.0, 99711.50144249233, 100062.49968750255, 103370.0, 103676.48161759143, 105164.0, 11142.72143196394, 11266.94366528162, 11554.59558915434, 11604.0, 11631.941840291083, 49080.50919490902, 50254.246186306504, 50274.74862625664, 50753.746231268604, 51725.48274517357, 62140.37859621346, 62561.68719156557, 62833.0, 63567.6821615889, 64480.67759661172, 15492.767608486107, 15665.451709190123, 15686.607834804221, 15789.289481973568, 15844.049357038615, 17941.102944852442, 18259.0, 18293.634127317113, 18385.356512521998, 18541.721874172166, 16117.194140292704, 16207.270672819515, 16208.51374458768, 16305.755413669041, 16340.019598824108, 17112.65774684524, 17364.131793410532, 17402.912985434992, 17413.39053133185, 17554.0, 16910.57723556921, 17226.655466890843, 17266.136693165543, 17491.38780142689, 17520.912395437943, 11937.104717146423, 11940.582079627171, 12017.158798884344, 12055.939720301343, 12065.638030858738, 14987.625309367353, 15872.76190857115, 15970.520884373487, 16076.0, 16421.096839673934], "value": 9543.82616556161, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 109.0, 98.0, 105.0, 105.0, 112.0, 107.0, 99.0, 106.0, 109.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 111.0, 138.0, 175.0, 115.0, 141.0, 140.0, 113.0, 172.0, 120.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 161.0, 164.0, 162.0, 163.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 189.0, 76.0, 74.0, 87.0, 75.0, 159.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 139.0, 77.0, 78.0, 78.0, 137.0, 79.0, 77.0, 120.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 47.0, 47.0, 49.0, 49.0, 48.0, 47.0, 48.0, 47.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 80.0, 80.0, 72.0, 74.0, 74.0, 72.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 124.0, 116.0, 117.0, 113.0, 114.0, 114.0, 118.0, 140.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 160.0, 163.0, 162.0, 172.0, 171.0, 158.0, 156.0, 159.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 63.0, 68.0, 63.0, 60.0, 60.0, 57.0], "value": 61.2, "unit": "score"}]}]} 19:44:55 INFO - Return code: 0 19:44:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:44:55 INFO - # TBPL SUCCESS # 19:44:55 INFO - Running post-action listener: _package_coverage_data 19:44:55 INFO - Running post-action listener: _resource_record_post_action 19:44:55 INFO - [mozharness: 2017-08-24 02:44:55.529701Z] Finished run-tests step (success) 19:44:55 INFO - Running post-run listener: _resource_record_post_run 19:44:55 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1077248; Write bytes: 389128192; Read time: 276; Write time: 356268 19:44:55 INFO - TinderboxPrint: CPU usage
13.0% 19:44:55 INFO - TinderboxPrint: I/O read bytes / time
1,077,248 / 276 19:44:55 INFO - TinderboxPrint: I/O write bytes / time
389,128,192 / 356,268 19:44:55 INFO - TinderboxPrint: CPU idle
8,217.1 (87.0%) 19:44:55 INFO - TinderboxPrint: CPU user
1,181.8 (12.5%) 19:44:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:44:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 109924352; Read time: 0; Write time: 124364 19:44:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:44:55 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 1073152; Write bytes: 279203840; Read time: 256; Write time: 231904 19:44:56 INFO - Running post-run listener: _upload_blobber_files 19:44:56 INFO - Blob upload gear active. 19:44:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:44:56 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:44:56 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:44:56 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:44:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:57 INFO - (blobuploader) - INFO - Done attempting. 19:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:44:58 INFO - (blobuploader) - INFO - Done attempting. 19:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:02 INFO - (blobuploader) - INFO - Done attempting. 19:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:45:03 INFO - (blobuploader) - INFO - Done attempting. 19:45:03 INFO - (blobuploader) - INFO - Iteration through files over. 19:45:03 INFO - Return code: 0 19:45:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:45:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:45:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ff41cb4c2cd9e097776973c66ff6da45512275735612d5923544b56c8e59146941c9185cb48fddfbe2b091876260417d2151614ce8ab9e5d461224f35066f42", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a57d44fc02f5ff2d1390da39ba7c6fa43fdf7fd5e4d215781cb7c8fcee6664c559e9c572579bb0e31be3ddfafaa6500ebc34273ab65cc3a4b3eb788223ddfca", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/639ff65c7dbaa0f47275764aebbdbdc6407ae57984eaa7a972b0283dffdce0a3d736461250caf0fd8d53d37c10e0bffa64648d7c37fa5cf8130932749774b125", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae8f4decbd2aeea22833ad4c2d87046771500542b81e5cb57645a8a6008396935d73a9167933c831e9deea36150dd0e15a010145b254b221b7c24c4faf4007ea"} 19:45:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:45:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:45:03 INFO - Contents: 19:45:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ff41cb4c2cd9e097776973c66ff6da45512275735612d5923544b56c8e59146941c9185cb48fddfbe2b091876260417d2151614ce8ab9e5d461224f35066f42", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a57d44fc02f5ff2d1390da39ba7c6fa43fdf7fd5e4d215781cb7c8fcee6664c559e9c572579bb0e31be3ddfafaa6500ebc34273ab65cc3a4b3eb788223ddfca", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/639ff65c7dbaa0f47275764aebbdbdc6407ae57984eaa7a972b0283dffdce0a3d736461250caf0fd8d53d37c10e0bffa64648d7c37fa5cf8130932749774b125", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae8f4decbd2aeea22833ad4c2d87046771500542b81e5cb57645a8a6008396935d73a9167933c831e9deea36150dd0e15a010145b254b221b7c24c4faf4007ea"} 19:45:03 INFO - Running post-run listener: copy_logs_to_upload_dir 19:45:03 INFO - Copying logs to upload dir... 19:45:03 INFO - mkdir: /builds/slave/test/build/upload/logs 19:45:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.135811 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-08-23 19:45:03.389169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:45:03.393678) ========= 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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ff41cb4c2cd9e097776973c66ff6da45512275735612d5923544b56c8e59146941c9185cb48fddfbe2b091876260417d2151614ce8ab9e5d461224f35066f42", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a57d44fc02f5ff2d1390da39ba7c6fa43fdf7fd5e4d215781cb7c8fcee6664c559e9c572579bb0e31be3ddfafaa6500ebc34273ab65cc3a4b3eb788223ddfca", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/639ff65c7dbaa0f47275764aebbdbdc6407ae57984eaa7a972b0283dffdce0a3d736461250caf0fd8d53d37c10e0bffa64648d7c37fa5cf8130932749774b125", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae8f4decbd2aeea22833ad4c2d87046771500542b81e5cb57645a8a6008396935d73a9167933c831e9deea36150dd0e15a010145b254b221b7c24c4faf4007ea"} build_url:https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/DeVpKF0aS6G-BU4rl_C_jQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ff41cb4c2cd9e097776973c66ff6da45512275735612d5923544b56c8e59146941c9185cb48fddfbe2b091876260417d2151614ce8ab9e5d461224f35066f42", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/4a57d44fc02f5ff2d1390da39ba7c6fa43fdf7fd5e4d215781cb7c8fcee6664c559e9c572579bb0e31be3ddfafaa6500ebc34273ab65cc3a4b3eb788223ddfca", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/639ff65c7dbaa0f47275764aebbdbdc6407ae57984eaa7a972b0283dffdce0a3d736461250caf0fd8d53d37c10e0bffa64648d7c37fa5cf8130932749774b125", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ae8f4decbd2aeea22833ad4c2d87046771500542b81e5cb57645a8a6008396935d73a9167933c831e9deea36150dd0e15a010145b254b221b7c24c4faf4007ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:45:03.427989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:45:03.428408) ========= 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=fa44defc139c4ba8574fe040000001db-1503541454.1299-951019900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:45:03.509447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:45:03.509806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:45:03.513366) ========= ========= Total master_lag: -0.11 =========