builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1490095507.47 results: success (0) buildid: 20170321024728 builduid: 4ece961f669e479f8b066ee50c732c5e revision: b32458403f1f335b457483c9dc62a9059364c6fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.465836) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.466293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.466589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.491748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.492103) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 04:25:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-03-21 04:25:07 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103632 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.619251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.619587) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:07.668656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:25:07.669030) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b32458403f1f335b457483c9dc62a9059364c6fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b32458403f1f335b457483c9dc62a9059364c6fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 04:25:07,693 truncating revision to first 12 chars 2017-03-21 04:25:07,693 Setting DEBUG logging. 2017-03-21 04:25:07,693 attempt 1/10 2017-03-21 04:25:07,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b32458403f1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 04:25:08,597 unpacking tar archive at: mozilla-beta-b32458403f1f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.174001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:25:08.867226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:08.867653) ========= script_repo_revision: b32458403f1f335b457483c9dc62a9059364c6fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:08.868140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:08.868467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:25:08.888533) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-21 04:25:08.888955) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:25:09 INFO - MultiFileLogger online at 20170321 04:25:09 in /builds/slave/test 04:25:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:25:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:09 INFO - {'append_to_log': False, 04:25:09 INFO - 'base_work_dir': '/builds/slave/test', 04:25:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:25:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:09 INFO - 'branch': 'Mozilla-Beta', 04:25:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:09 INFO - 'config_files': ('talos/mac_config.py',), 04:25:09 INFO - 'default_actions': ('clobber', 04:25:09 INFO - 'read-buildbot-config', 04:25:09 INFO - 'download-and-extract', 04:25:09 INFO - 'populate-webroot', 04:25:09 INFO - 'create-virtualenv', 04:25:09 INFO - 'install', 04:25:09 INFO - 'run-tests'), 04:25:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:09 INFO - 'download_minidump_stackwalk': True, 04:25:09 INFO - 'download_symbols': 'ondemand', 04:25:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:09 INFO - 'installer_path': 'installer.exe', 04:25:09 INFO - 'log_level': 'info', 04:25:09 INFO - 'log_name': 'talos', 04:25:09 INFO - 'log_to_console': True, 04:25:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:09 INFO - 'opt_config_files': (), 04:25:09 INFO - 'pip_index': False, 04:25:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:09 INFO - 'cmd': ('bash', 04:25:09 INFO - '-c', 04:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:09 INFO - 'enabled': True, 04:25:09 INFO - 'halt_on_failure': False, 04:25:09 INFO - 'name': 'check_screen_resolution'},), 04:25:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:09 INFO - 'cmd': ('bash', 04:25:09 INFO - '-c', 04:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:09 INFO - 'enabled': True, 04:25:09 INFO - 'halt_on_failure': False, 04:25:09 INFO - 'name': 'check_screen_resolution'},), 04:25:09 INFO - 'run_cmd_checks_enabled': True, 04:25:09 INFO - 'sps_profile': False, 04:25:09 INFO - 'sps_profile_interval': 0, 04:25:09 INFO - 'suite': 'dromaeojs', 04:25:09 INFO - 'system_bits': '32', 04:25:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:09 INFO - 'title': 't-yosemite-r7-0143', 04:25:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:09 INFO - 'use_talos_json': True, 04:25:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:09 INFO - 'work_dir': 'build'} 04:25:09 INFO - [mozharness: 2017-03-21 11:25:09.038073Z] Running clobber step. 04:25:09 INFO - Running pre-action listener: _resource_record_pre_action 04:25:09 INFO - Running main action method: clobber 04:25:09 INFO - rmtree: /builds/slave/test/build 04:25:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:10 INFO - Running post-action listener: _resource_record_post_action 04:25:10 INFO - [mozharness: 2017-03-21 11:25:10.829579Z] Finished clobber step (success) 04:25:10 INFO - [mozharness: 2017-03-21 11:25:10.829766Z] Running read-buildbot-config step. 04:25:10 INFO - Running pre-action listener: _resource_record_pre_action 04:25:10 INFO - Running main action method: read_buildbot_config 04:25:10 INFO - Using buildbot properties: 04:25:10 INFO - { 04:25:10 INFO - "project": "", 04:25:10 INFO - "product": "firefox", 04:25:10 INFO - "script_repo_revision": "production", 04:25:10 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:25:10 INFO - "repository": "", 04:25:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:25:10 INFO - "buildid": "20170321024728", 04:25:10 INFO - "pgo_build": "False", 04:25:10 INFO - "basedir": "/builds/slave/test", 04:25:10 INFO - "buildnumber": 1, 04:25:10 INFO - "slavename": "t-yosemite-r7-0143", 04:25:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:25:10 INFO - "platform": "yosemite_r7", 04:25:10 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:25:10 INFO - "branch": "mozilla-beta", 04:25:10 INFO - "repo_path": "releases/mozilla-beta", 04:25:10 INFO - "revision": "b32458403f1f335b457483c9dc62a9059364c6fb", 04:25:10 INFO - "stage_platform": "macosx64", 04:25:10 INFO - "builduid": "4ece961f669e479f8b066ee50c732c5e", 04:25:10 INFO - "slavebuilddir": "test" 04:25:10 INFO - } 04:25:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 04:25:10 INFO - Running post-action listener: _resource_record_post_action 04:25:10 INFO - [mozharness: 2017-03-21 11:25:10.833578Z] Finished read-buildbot-config step (success) 04:25:10 INFO - [mozharness: 2017-03-21 11:25:10.833699Z] Running download-and-extract step. 04:25:10 INFO - Running pre-action listener: _resource_record_pre_action 04:25:10 INFO - Running main action method: download_and_extract 04:25:10 INFO - mkdir: /builds/slave/test/build/tests 04:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:10 INFO - trying https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 04:25:10 INFO - Downloading https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 04:25:12 INFO - Downloaded 1165 bytes. 04:25:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:25:12 INFO - Using the following test package requirements: 04:25:12 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:25:12 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 04:25:12 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 04:25:12 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:25:12 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 04:25:12 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:25:12 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 04:25:12 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 04:25:12 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 04:25:12 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:25:12 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 04:25:12 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 04:25:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:25:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:25:12 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:25:13 INFO - Expected file size: 16108131 04:25:13 INFO - Obtained file size: 16108131 04:25:19 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:25:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:25:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:25:19 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:25:20 INFO - Expected file size: 16108131 04:25:20 INFO - Obtained file size: 16108131 04:25:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 04:25:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 04:25:26 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 04:25:28 INFO - Expected file size: 14403663 04:25:28 INFO - Obtained file size: 14403663 04:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:28 INFO - trying https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:25:28 INFO - Downloading https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 04:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 04:25:30 INFO - Downloaded 58738506 bytes. 04:25:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:25:30 INFO - mkdir: /builds/slave/test/properties 04:25:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:30 INFO - Contents: 04:25:30 INFO - build_url:https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:25:31 INFO - Running post-action listener: _resource_record_post_action 04:25:31 INFO - Running post-action listener: set_extra_try_arguments 04:25:31 INFO - [mozharness: 2017-03-21 11:25:31.118119Z] Finished download-and-extract step (success) 04:25:31 INFO - [mozharness: 2017-03-21 11:25:31.118242Z] Running populate-webroot step. 04:25:31 INFO - Running pre-action listener: _resource_record_pre_action 04:25:31 INFO - Running main action method: populate_webroot 04:25:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:31 INFO - '--tppagecycles', 04:25:31 INFO - '7'], 04:25:31 INFO - 'tests': ['tsvgm']}}, 04:25:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['damp', 'tps']}, 04:25:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'tests': ['damp', 'tps']}, 04:25:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['dromaeo_dom']}, 04:25:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['basic_compositor_video']}, 04:25:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['a11yr', 04:25:31 INFO - 'ts_paint', 04:25:31 INFO - 'tpaint', 04:25:31 INFO - 'sessionrestore', 04:25:31 INFO - 'sessionrestore_no_auto_restore', 04:25:31 INFO - 'tabpaint']}, 04:25:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tsvgx', 04:25:31 INFO - 'tsvgr_opacity', 04:25:31 INFO - 'tart', 04:25:31 INFO - 'tscrollx', 04:25:31 INFO - 'cart', 04:25:31 INFO - 'tsvg_static']}, 04:25:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:31 INFO - 'tsvgr_opacity', 04:25:31 INFO - 'tart', 04:25:31 INFO - 'tscrollx', 04:25:31 INFO - 'cart', 04:25:31 INFO - 'tsvg_static']}, 04:25:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s'], 04:25:31 INFO - 'tests': ['tp5o']}, 04:25:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'talos_options': ['--disable-e10s', 04:25:31 INFO - '--xperf_path', 04:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:31 INFO - 'tests': ['tp5n']}, 04:25:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:31 INFO - 'talos_options': ['--xperf_path', 04:25:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:31 INFO - 'tests': ['tp5n']}}, 04:25:31 INFO - 'talos.zip': {'path': '', 04:25:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:31 INFO - Running post-action listener: _resource_record_post_action 04:25:31 INFO - [mozharness: 2017-03-21 11:25:31.136676Z] Finished populate-webroot step (success) 04:25:31 INFO - [mozharness: 2017-03-21 11:25:31.136807Z] Running create-virtualenv step. 04:25:31 INFO - Running pre-action listener: _resource_record_pre_action 04:25:31 INFO - Running main action method: create_virtualenv 04:25:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:31 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 04:25:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:31 INFO - Using real prefix '/tools/python27' 04:25:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:35 INFO - Installing pip.................done. 04:25:35 INFO - Return code: 0 04:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:35 INFO - Reading from file tmpfile_stdout 04:25:35 INFO - Output received: 04:25:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:25:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:35 INFO - 'HOME': '/Users/cltbld', 04:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:35 INFO - 'LOGNAME': 'cltbld', 04:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:35 INFO - 'MOZ_NO_REMOTE': '1', 04:25:35 INFO - 'NO_EM_RESTART': '1', 04:25:35 INFO - 'PAGER': '/bin/cat', 04:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:35 INFO - 'PWD': '/builds/slave/test', 04:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:35 INFO - 'SHELL': '/bin/bash', 04:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:35 INFO - 'USER': 'cltbld', 04:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:35 INFO - 'XPC_FLAGS': '0x0', 04:25:35 INFO - 'XPC_SERVICE_NAME': '0', 04:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:35 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 04:25:35 INFO - Cleaning up... 04:25:35 INFO - Return code: 0 04:25:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:35 INFO - 'HOME': '/Users/cltbld', 04:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:35 INFO - 'LOGNAME': 'cltbld', 04:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:35 INFO - 'MOZ_NO_REMOTE': '1', 04:25:35 INFO - 'NO_EM_RESTART': '1', 04:25:35 INFO - 'PAGER': '/bin/cat', 04:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:35 INFO - 'PWD': '/builds/slave/test', 04:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:35 INFO - 'SHELL': '/bin/bash', 04:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:35 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:35 INFO - 'USER': 'cltbld', 04:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:35 INFO - 'XPC_FLAGS': '0x0', 04:25:35 INFO - 'XPC_SERVICE_NAME': '0', 04:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:35 INFO - Downloading/unpacking psutil>=3.1.1 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:39 INFO - Installing collected packages: psutil 04:25:39 INFO - Running setup.py install for psutil 04:25:39 INFO - building 'psutil._psutil_osx' extension 04:25:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:25:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:25:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:25:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:25:39 INFO - building 'psutil._psutil_posix' extension 04:25:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:25:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:39 INFO - ^ 04:25:39 INFO - 1 warning generated. 04:25:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:40 INFO - Successfully installed psutil 04:25:40 INFO - Cleaning up... 04:25:40 INFO - Return code: 0 04:25:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:40 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:40 INFO - 'HOME': '/Users/cltbld', 04:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:40 INFO - 'LOGNAME': 'cltbld', 04:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:40 INFO - 'MOZ_NO_REMOTE': '1', 04:25:40 INFO - 'NO_EM_RESTART': '1', 04:25:40 INFO - 'PAGER': '/bin/cat', 04:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:40 INFO - 'PWD': '/builds/slave/test', 04:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:40 INFO - 'SHELL': '/bin/bash', 04:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:40 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:40 INFO - 'USER': 'cltbld', 04:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:40 INFO - 'XPC_FLAGS': '0x0', 04:25:40 INFO - 'XPC_SERVICE_NAME': '0', 04:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:40 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 04:25:40 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 04:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 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 04:25:40 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 04:25:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:43 INFO - Installing collected packages: mozsystemmonitor 04:25:43 INFO - Running setup.py install for mozsystemmonitor 04:25:43 INFO - Successfully installed mozsystemmonitor 04:25:43 INFO - Cleaning up... 04:25:43 INFO - Return code: 0 04:25:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:43 INFO - 'HOME': '/Users/cltbld', 04:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:43 INFO - 'LOGNAME': 'cltbld', 04:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:43 INFO - 'MOZ_NO_REMOTE': '1', 04:25:43 INFO - 'NO_EM_RESTART': '1', 04:25:43 INFO - 'PAGER': '/bin/cat', 04:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:43 INFO - 'PWD': '/builds/slave/test', 04:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:43 INFO - 'SHELL': '/bin/bash', 04:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:43 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:43 INFO - 'USER': 'cltbld', 04:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:43 INFO - 'XPC_FLAGS': '0x0', 04:25:43 INFO - 'XPC_SERVICE_NAME': '0', 04:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:43 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 04:25:43 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 04:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:43 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 04:25:43 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 04:25:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:46 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 04:25:46 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 04:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:46 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 04:25:46 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 04:25:46 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:46 INFO - warning: no files found matching '*.txt' 04:25:46 INFO - no previously-included directories found matching 'build' 04:25:46 INFO - no previously-included directories found matching 'dist' 04:25:46 INFO - no previously-included directories found matching '.git*' 04:25:46 INFO - Installing collected packages: jsonschema, functools32 04:25:46 INFO - Running setup.py install for functools32 04:25:46 INFO - warning: no files found matching '*.txt' 04:25:46 INFO - no previously-included directories found matching 'build' 04:25:46 INFO - no previously-included directories found matching 'dist' 04:25:46 INFO - no previously-included directories found matching '.git*' 04:25:47 INFO - Successfully installed jsonschema functools32 04:25:47 INFO - Cleaning up... 04:25:47 INFO - Return code: 0 04:25:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:47 INFO - 'HOME': '/Users/cltbld', 04:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:47 INFO - 'LOGNAME': 'cltbld', 04:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:47 INFO - 'MOZ_NO_REMOTE': '1', 04:25:47 INFO - 'NO_EM_RESTART': '1', 04:25:47 INFO - 'PAGER': '/bin/cat', 04:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:47 INFO - 'PWD': '/builds/slave/test', 04:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:47 INFO - 'SHELL': '/bin/bash', 04:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:47 INFO - 'USER': 'cltbld', 04:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:47 INFO - 'XPC_FLAGS': '0x0', 04:25:47 INFO - 'XPC_SERVICE_NAME': '0', 04:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:47 INFO - Cleaning up... 04:25:47 INFO - Return code: 0 04:25:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:47 INFO - 'HOME': '/Users/cltbld', 04:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:47 INFO - 'LOGNAME': 'cltbld', 04:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:47 INFO - 'MOZ_NO_REMOTE': '1', 04:25:47 INFO - 'NO_EM_RESTART': '1', 04:25:47 INFO - 'PAGER': '/bin/cat', 04:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:47 INFO - 'PWD': '/builds/slave/test', 04:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:47 INFO - 'SHELL': '/bin/bash', 04:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:47 INFO - 'USER': 'cltbld', 04:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:47 INFO - 'XPC_FLAGS': '0x0', 04:25:47 INFO - 'XPC_SERVICE_NAME': '0', 04:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:47 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:47 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 04:25:47 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 04:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:47 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 04:25:47 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 04:25:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:50 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 04:25:50 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 04:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:50 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 04:25:50 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 04:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:51 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 04:25:51 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 04:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:51 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 04:25:51 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 04:25:51 INFO - Downloading docopt-0.6.1.tar.gz 04:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:51 INFO - Running setup.py install for blobuploader 04:25:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:51 INFO - Running setup.py install for requests 04:25:52 INFO - Running setup.py install for docopt 04:25:52 INFO - Successfully installed blobuploader requests docopt 04:25:52 INFO - Cleaning up... 04:25:52 INFO - Return code: 0 04:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:52 INFO - 'HOME': '/Users/cltbld', 04:25:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:52 INFO - 'LOGNAME': 'cltbld', 04:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:52 INFO - 'MOZ_NO_REMOTE': '1', 04:25:52 INFO - 'NO_EM_RESTART': '1', 04:25:52 INFO - 'PAGER': '/bin/cat', 04:25:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:52 INFO - 'PWD': '/builds/slave/test', 04:25:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:52 INFO - 'SHELL': '/bin/bash', 04:25:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:52 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:52 INFO - 'USER': 'cltbld', 04:25:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:52 INFO - 'XPC_FLAGS': '0x0', 04:25:52 INFO - 'XPC_SERVICE_NAME': '0', 04:25:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ztA6J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wVu7hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:52 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ooNVPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-7KAkoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-OwKRgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-GBN52Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1gdeRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rsyZLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-bWS1Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ybWqmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rv8_C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:53 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kcLRvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-xG99aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AofBjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-t7N2gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HcIyiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:54 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sjEqwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:54 INFO - Running setup.py install for manifestparser 04:25:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:54 INFO - Running setup.py install for mozcrash 04:25:54 INFO - Running setup.py install for mozdebug 04:25:54 INFO - Running setup.py install for mozdevice 04:25:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozfile 04:25:55 INFO - Running setup.py install for mozhttpd 04:25:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozinfo 04:25:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozInstall 04:25:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:55 INFO - Running setup.py install for mozleak 04:25:55 INFO - Running setup.py install for mozlog 04:25:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for moznetwork 04:25:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozprocess 04:25:56 INFO - Running setup.py install for mozprofile 04:25:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozrunner 04:25:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:56 INFO - Running setup.py install for mozscreenshot 04:25:56 INFO - Running setup.py install for moztest 04:25:56 INFO - Running setup.py install for mozversion 04:25:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:57 INFO - Cleaning up... 04:25:57 INFO - Return code: 0 04:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:25:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:57 INFO - 'HOME': '/Users/cltbld', 04:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:57 INFO - 'LOGNAME': 'cltbld', 04:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:57 INFO - 'MOZ_NO_REMOTE': '1', 04:25:57 INFO - 'NO_EM_RESTART': '1', 04:25:57 INFO - 'PAGER': '/bin/cat', 04:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:57 INFO - 'PWD': '/builds/slave/test', 04:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:57 INFO - 'SHELL': '/bin/bash', 04:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:25:57 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:57 INFO - 'USER': 'cltbld', 04:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:57 INFO - 'XPC_FLAGS': '0x0', 04:25:57 INFO - 'XPC_SERVICE_NAME': '0', 04:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-VjeIfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:57 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)) 04:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-UnaO9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:57 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)) 04:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-DIh2mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:57 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)) 04:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-p12IN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-3wooA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Hd5kUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-UFGUfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YZUGwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-FzfTmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-E_atQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-T_vA3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-b4bEuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Y8Fx86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cBc1G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:58 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)) 04:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:58 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-p0X3wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:59 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cv4mxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:59 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)) 04:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:59 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-B18Cnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:59 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)) 04:25:59 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)) 04:25:59 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)) 04:25:59 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)) 04:25:59 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:59 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25: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 04:25: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 04:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25: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 04:25: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 04:26:01 INFO - Downloading blessings-1.6.tar.gz 04:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:02 INFO - Installing collected packages: blessings 04:26:02 INFO - Running setup.py install for blessings 04:26:02 INFO - Successfully installed blessings 04:26:02 INFO - Cleaning up... 04:26:02 INFO - Return code: 0 04:26:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:02 INFO - Reading from file tmpfile_stdout 04:26:02 INFO - Current package versions: 04:26:02 INFO - blessings == 1.6 04:26:02 INFO - blobuploader == 1.2.4 04:26:02 INFO - docopt == 0.6.1 04:26:02 INFO - functools32 == 3.2.3-2 04:26:02 INFO - jsonschema == 2.5.1 04:26:02 INFO - manifestparser == 1.1 04:26:02 INFO - mozInstall == 1.12 04:26:02 INFO - mozcrash == 1.0 04:26:02 INFO - mozdebug == 0.1 04:26:02 INFO - mozdevice == 0.49 04:26:02 INFO - mozfile == 1.2 04:26:02 INFO - mozhttpd == 0.7 04:26:02 INFO - mozinfo == 0.9 04:26:02 INFO - mozleak == 0.1 04:26:02 INFO - mozlog == 3.4 04:26:02 INFO - moznetwork == 0.27 04:26:02 INFO - mozprocess == 0.24 04:26:02 INFO - mozprofile == 0.28 04:26:02 INFO - mozrunner == 6.13 04:26:02 INFO - mozscreenshot == 0.1 04:26:02 INFO - mozsystemmonitor == 0.3 04:26:02 INFO - moztest == 0.8 04:26:02 INFO - mozversion == 1.4 04:26:02 INFO - psutil == 3.1.1 04:26:02 INFO - requests == 1.2.3 04:26:02 INFO - wsgiref == 0.1.2 04:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:26:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:26:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:02 INFO - 'HOME': '/Users/cltbld', 04:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:02 INFO - 'LOGNAME': 'cltbld', 04:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:02 INFO - 'MOZ_NO_REMOTE': '1', 04:26:02 INFO - 'NO_EM_RESTART': '1', 04:26:02 INFO - 'PAGER': '/bin/cat', 04:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:02 INFO - 'PWD': '/builds/slave/test', 04:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:02 INFO - 'SHELL': '/bin/bash', 04:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:26:02 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:02 INFO - 'USER': 'cltbld', 04:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:02 INFO - 'XPC_FLAGS': '0x0', 04:26:02 INFO - 'XPC_SERVICE_NAME': '0', 04:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 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)) 04:26:02 INFO - Cleaning up... 04:26:02 INFO - Return code: 0 04:26:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:02 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x10469fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3ea490ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:02 INFO - 'HOME': '/Users/cltbld', 04:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:02 INFO - 'LOGNAME': 'cltbld', 04:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:02 INFO - 'MOZ_NO_REMOTE': '1', 04:26:02 INFO - 'NO_EM_RESTART': '1', 04:26:02 INFO - 'PAGER': '/bin/cat', 04:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:02 INFO - 'PWD': '/builds/slave/test', 04:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:02 INFO - 'SHELL': '/bin/bash', 04:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:26:02 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:02 INFO - 'USER': 'cltbld', 04:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:02 INFO - 'XPC_FLAGS': '0x0', 04:26:02 INFO - 'XPC_SERVICE_NAME': '0', 04:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:03 INFO - Cleaning up... 04:26:03 INFO - Return code: 0 04:26:03 INFO - Running post-action listener: _resource_record_post_action 04:26:03 INFO - Running post-action listener: _start_resource_monitoring 04:26:03 INFO - Starting resource monitoring. 04:26:03 INFO - [mozharness: 2017-03-21 11:26:03.126818Z] Finished create-virtualenv step (success) 04:26:03 INFO - [mozharness: 2017-03-21 11:26:03.127784Z] Running install step. 04:26:03 INFO - Running pre-action listener: _resource_record_pre_action 04:26:03 INFO - Running main action method: install 04:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:03 INFO - Reading from file tmpfile_stdout 04:26:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:03 INFO - Reading from file tmpfile_stdout 04:26:03 INFO - Output received: 04:26:03 INFO - Usage: mozinstall [options] installer 04:26:03 INFO - Options: 04:26:03 INFO - -h, --help show this help message and exit 04:26:03 INFO - -d DEST, --destination=DEST 04:26:03 INFO - Directory to install application into. [default: 04:26:03 INFO - "/builds/slave/test"] 04:26:03 INFO - --app=APP Application being installed. [default: firefox] 04:26:03 INFO - mkdir: /builds/slave/test/build/application 04:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:26:18 INFO - Reading from file tmpfile_stdout 04:26:18 INFO - Output received: 04:26:18 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:26:18 INFO - Running post-action listener: _resource_record_post_action 04:26:18 INFO - [mozharness: 2017-03-21 11:26:18.132720Z] Finished install step (success) 04:26:18 INFO - [mozharness: 2017-03-21 11:26:18.132892Z] Running run-tests step. 04:26:18 INFO - Running pre-action listener: _resource_record_pre_action 04:26:18 INFO - Running main action method: run_tests 04:26:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:18 INFO - 2017-03-21 04:26:18.147 screenresolution[2196:25657] starting screenresolution argv=screenresolution get 04:26:18 INFO - 2017-03-21 04:26:18.150 screenresolution[2196:25657] Display 0: 1600x1200x32@60 04:26:18 INFO - 2017-03-21 04:26:18.156 screenresolution[2197:25659] starting screenresolution argv=screenresolution list 04:26:18 INFO - Available Modes on Display 0 04:26:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:18 INFO - Intel Iris: 04:26:18 INFO - Chipset Model: Intel Iris 04:26:18 INFO - Type: GPU 04:26:18 INFO - Bus: Built-In 04:26:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:18 INFO - Vendor: Intel (0x8086) 04:26:18 INFO - Device ID: 0x0a2e 04:26:18 INFO - Revision ID: 0x0009 04:26:18 INFO - Displays: 04:26:18 INFO - Display: 04:26:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:18 INFO - Display Serial Number: 1600x1200 60 04:26:18 INFO - Main Display: Yes 04:26:18 INFO - Mirror: Off 04:26:18 INFO - Online: Yes 04:26:18 INFO - Rotation: Supported 04:26:18 INFO - Return code: 0 04:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:18 INFO - Python 2.7.3 04:26:18 INFO - Return code: 0 04:26:18 INFO - grabbing minidump binary from tooltool 04:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:26:18 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/macosx64/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 0x10447dd30>, '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 0x1043a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104472be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:18 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:26:18 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:26:18 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:26:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:18 INFO - Return code: 0 04:26:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TrRDM9R9OH/Render', 04:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:18 INFO - 'HOME': '/Users/cltbld', 04:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:18 INFO - 'LOGNAME': 'cltbld', 04:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:18 INFO - 'MOZ_NO_REMOTE': '1', 04:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:18 INFO - 'NO_EM_RESTART': '1', 04:26:18 INFO - 'PAGER': '/bin/cat', 04:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:18 INFO - 'PWD': '/builds/slave/test', 04:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:18 INFO - 'SHELL': '/bin/bash', 04:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners', 04:26:18 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 04:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:18 INFO - 'USER': 'cltbld', 04:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:18 INFO - 'XPC_FLAGS': '0x0', 04:26:18 INFO - 'XPC_SERVICE_NAME': '0', 04:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:26:18 INFO - mozversion application_buildid: 20170321024728 04:26:18 INFO - mozversion application_changeset: b32458403f1f335b457483c9dc62a9059364c6fb 04:26:18 INFO - mozversion application_display_name: Firefox 04:26:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:18 INFO - mozversion application_name: Firefox 04:26:18 INFO - mozversion application_remotingname: firefox 04:26:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:26:18 INFO - mozversion application_vendor: Mozilla 04:26:18 INFO - mozversion application_version: 53.0 04:26:18 INFO - mozversion platform_buildid: 20170321024728 04:26:18 INFO - mozversion platform_changeset: b32458403f1f335b457483c9dc62a9059364c6fb 04:26:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:26:18 INFO - mozversion platform_version: 53.0 04:26:18 INFO - using testdate: 1490095578 04:26:18 INFO - actual date: 1490095578 04:26:18 INFO - starting webserver on 'localhost:57537' 04:26:18 INFO - SUITE-START | Running 2 tests 04:26:18 INFO - TEST-START | dromaeo_css 04:26:18 INFO - operating with platform_type : mac_ 04:26:18 INFO - Initialising browser for dromaeo_css test... 04:26:18 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpXNuEy1/profile http://localhost:57537/getInfo.html) 04:26:21 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 04:26:21 INFO - PROCESS | 2207 | colorDepth:24 04:26:21 INFO - PROCESS | 2207 | Browser inner width/height: 1024/689 04:26:21 INFO - PROCESS | 2207 | __metrics 04:26:21 INFO - PROCESS | 2207 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:21 INFO - PROCESS | 2207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:21 INFO - TEST-INFO | 2207: exit 0 04:26:21 INFO - Browser initialized. 04:26:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:21 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpXNuEy1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:33 INFO - PROCESS | 2210 | RSS: Main: 167301120 04:26:33 INFO - PROCESS | 2210 | 04:29:36 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57537/tests/dromaeo/cssquery-ext.html) 04:29:37 INFO - PROCESS | 2210 | RSS: Main: 321486848 04:29:37 INFO - PROCESS | 2210 | 04:32:40 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-ext.html (next: http://localhost:57537/tests/dromaeo/cssquery-jquery.html) 04:32:41 INFO - PROCESS | 2210 | RSS: Main: 310345728 04:32:41 INFO - PROCESS | 2210 | 04:35:43 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57537/tests/dromaeo/cssquery-mootools.html) 04:35:44 INFO - PROCESS | 2210 | RSS: Main: 287588352 04:35:44 INFO - PROCESS | 2210 | 04:38:46 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57537/tests/dromaeo/cssquery-prototype.html) 04:38:46 INFO - PROCESS | 2210 | RSS: Main: 285736960 04:38:46 INFO - PROCESS | 2210 | 04:41:50 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57537/tests/dromaeo/cssquery-yui.html) 04:41:51 INFO - PROCESS | 2210 | RSS: Main: 268025856 04:41:51 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:57537/tests/dromaeo/cssquery-yui.html (next: http://localhost:57537/tests/dromaeo/cssquery-dojo.html) 04:44:54 INFO - PROCESS | 2210 | RSS: Main: 462680064 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | __start_tp_report 04:44:54 INFO - PROCESS | 2210 | _x_x_mozilla_page_load 04:44:54 INFO - PROCESS | 2210 | _x_x_mozilla_page_load_details 04:44:54 INFO - PROCESS | 2210 | |i|pagename|runs| 04:44:54 INFO - PROCESS | 2210 | |0;dojo.html;2915.8542072896357;3445.5865296164466;3458.688718015378;3501.2822371413863;3501.7023552997994;5823.65058096514;5828.679422631753;5832.8042751236;5844.152597873311;5852.736626851792;5831.854203644911;5854.853628659275;5909.320428150764;5909.586328956974;5939.435753603411;5226.660267082628;5274.077036518594;5320.654157479771;5321.414644389114;5352.277442545245;5223.190405487156;5257.1851363038595;5258.684478931257;5380.031594313022;5394.406615272336;5287.4976877196605;5318.73406329682;5320.441353657869;5342.332208473941;5386.649867758583;5355.946440535603;5361.142217245222;5362.517373436371;5365.7585408656705;5375.43557926416;5210.843674689765;5217.34783152106;5219.217117432378;5280.788768449257;5352.330958630171;5806.129080637938;5807.361190269067;5895.675737834417;5921.141434492018;5971.0744834550715;6205.7517699291975;6222.471089957359;6225.128482012522;6227;6247.406496382836;6232.283287421959;6264.843378915518;6290;6314.116023756677;6321.841953951142;5004.724740139254;5897.882042359129;5903.763849446017;5924.703764811742;5984.521238300926;6328.050792381087;6332.8416789579705;6333.334999825044;6340.873182536324;6363.427291543783;6244.1570387997945;6276.246850377984;6276.843078922972;6284.748610055546;6293.559450838397;6223.564350495512;6229.781957631461;6288.968555157287;6295.401936816087;6310.5267104967315;5160.406553246425;5292.947070529322;6315.115883776275;6340.048992651047;6340.7463701451425;6280.654563999024;6322.241331040213;6339.461145802658;6347.428731414195;6358.23701155855;4991.850244492671;5021.548060674557;5048.747562621854;5104.259882317043;5125.948740512622;4542.727436353829;4550.658700597469;4577.61090307321;4581.79381927814;4582.358469814229;5861.6189947653265;6001.2498437695285;6004.759809607567;6009.609375390585;6017.308009578955;6265.906011409833;6266.49868010558;6271.372862713783;6279.3720627937755;6285.528585356116;5821.854453638693;5882.117682347682;5917;5955.136505206808;5968.283805943314;4598.770061496912;5394.460553944574;5421.566274698014;5493.285872836505;5558.388577256498;6298.7480500780375;6387.105805187278;6389.648569328639;6398.552101352953;6400.039994000937;6242.968785156045;6275.278342990615;6295.055741638791;6305.558610897193;6317.842053948688;6230.937690623035;6275.811725648238;6378.840528986812;6378.9362106380195;6396.48828093742;5789.363170051207;6253.906191407042;6270.843228919131;6332.620042797447;6347.96826015867;6312.747490100344;6335.588186767845;6342.302346741762;6362.331955144643;6372.330905254881;6129.817282374446;6142;6213.161223234805;6245.28179259391;6281.560290779602;6186.19579454686;6198.690065496798;6256.874862502634;6262.09199666055;6280.434760871543;6165.599236049642;6171.722272497838;6180.721867516063;6187.443130118311;6195.845103872439;6039.214902062704;6284.371562843862;6288.276848162337;6295.433410993032;6302.3067462578165;6003.669798161143;6091.390860913873;6104.481119104926;6117.825149509824;6158.7228574715145 04:44:54 INFO - PROCESS | 2210 | |1;ext.html;455.78122501199425;486.15651844050564;487.9951200487995;504.3569448952587;535.9495389037486;28422.57366139507;42668.93327666806;44281.11437771242;44457.555424445745;46193.07613847729;45946.31080533786;46547.767261163644;46609.533904660944;46696.76651616746;46706.53293467064;9713.174380177676;9910.504474776268;9915.801683966316;9929.851052234222;9941.055599718014;8644.870326945102;9143.177114059734;11136.387498687569;12151;12174.269543827399;11906.285622862613;11921.523139074427;12165.148439609231;12210.023198144127;12241.449134788956;12147.21043132198;12237.265764054186;12255.448504817305;12267;12278.201916875463;12091.697707557294;12192.939035304855;12194.207376520499;12197.939010304892;12209.633710988684;43033.35449968253;43434.78282608598;43442.56557434449;43527.56472435267;43622;4074.1311053601453;4106.1992911382295;4125.484314460692;4139.110091330348;4170.70805043647;31214.687853121406;31962;32323.838380807945;33403.16492087693;33690.66309336924;3099.9535006974916;3119.1110533497845;3132.4988001919583;3147.2446612812987;3189.952150717741;505163;506592;506817;507362.99999999633;507952;66305.33694663088;66611.66694166498;66667;66719.66640166768;66726.66636666785;68923.65538172277;68963.3103668967;69074.3092569078;69193;69198.65400672964;17927.73108403375;18128.184231709605;18141.546461338574;18149.911005339723;18151.818481815277;12679.922206612357;13840.861591384159;14015.929920350332;14015.929920350536;14023.228722420365;15301.46444874424;15724.29240684172;17080.57298567546;17499.30002799874;17540.649187016188;5631.577631677641;6036.577439579275;6573.934260657428;6595.670216489157;6617.239017513048;830.5224495914873;878.83302172587;881.0968757024101;918.2699753695828;927.7448701607112;28141.859290703826;30605.846970765004;30767.923122690598;30834.074977750704;31468.685313147034;1045.7281106912258;1067.64767626683;1069.1286601419818;1091.4542728635681;1123.994380028111;15846.449825058027;16028.358865645243;16042.518724438285;16178.352865885468;16419.01485910849;549907;552730.2363488157;553626;557017;560096;51150;55759.88480230373;56953.430465694815;62747.6862615684;64351.67824160943;1391.8608139186204;1443.7906503556715;1447.3125265498804;1455.9126452412888;1457.1912588513264;30460.84769576138;31901.521477177397;32165.839170803996;32768.344633107685;33021.83489082539;53025.469745302056;53709.73145134249;54011;54284.45715542794;54374;589758;620204;620474;630654;641634;39463;40465.39301910532;40725.592744073365;40831.59168408278;40896;46184.84336409739;47214.527854722386;47630.761846190544;47844;48756.756216218695;37399.626003740705;38653;38834.61165388423;39143.95026303231;40240.79277621676;38346.61653383542;38501.80749096237;39644.008899777735;39754;39841;29282.560761588167;37497.6250237505;37631.43552846655;37965.43051854169;38198.427023594115;31041.534376984815;33567.49648755222;34155.48766768451;34204.657953420145;34630.480542792386;22622.321330360115;25018.999240030196;25128.617926013514;25302.49395012126;25599.74400256048 04:44:54 INFO - PROCESS | 2210 | |2;jquery.html;393.470781798481;401.91683413201395;410.99589004109947;417.12195827782506;437.7045494291352;20937.95310234488;21026.264080757177;22320.88839555804;22359.32922012338;22956;13770;22151.667724984138;22246.887655617236;23033.769662303373;23222;5469.863253418666;5712.828615141552;5722.227499287585;5740.1102829061565;5746.051901436279;5540;5639.6334238274585;5644.238027866227;6110;6190.81427557174;6162.7534898604;6165.136880836686;6174.289956654975;6175.938240617604;6177.938220617782;5930.466258036776;6129.509639228851;6155.138280640714;6187.16473276111;6203.2245969253845;5385.111456609655;5533.3083364579425;5535.889282214333;5550.16747487876;5552.69460179694;13701.86298137016;14265.215413152273;14286.928480363911;14288.85711142896;14292.071015383966;2670.639463672399;2688.4891870544534;2706.9593956090675;2738.931526711828;2796.9440611187865;9270.258379329638;10714.410707411089;10985.285956412887;15073.332833620712;15926.681466370723;1867.9626407471774;1906.4661894669514;1970.5763260898975;1978.8515861310316;2100.915963361479;121899;128961.35519322437;140259;140880.59119408778;147290.26354868265;12016.759664806656;12265.816012759815;12329.349189924209;12345.382730863601;12841.48634054646;16916.661666766595;16965.321387144377;16973.575660608585;16978.151092445576;17008.744868826976;9159.862602060974;9361.110694484014;9438.622455101857;9556.092171243721;9582.66460673873;8353.289970352467;8671.262942649819;8766.430182038275;8959.5968181432;9158.358914876027;4934.777934992934;5016.297718319438;5020.322256495327;5120.231965205175;5122.871928201825;1720.8279172082691;2083.802038806311;2092.6756352765346;2093.5184907471366;2106.462851972737;884.75669190973;992.4095163377779;996.6960077176531;1012.3824467075078;1047.486731501574;18808.623827523374;22435;23005.309840704806;23070.884645576665;23099.653505197435;1047.617619568852;1053.2311412668641;1054.7204990677476;1064.9627263045757;1067.690369792767;11191.328520288645;11532.192746507664;11758.05935525156;11832.645020649394;11842.76314473723;693803.8502288903;804915.9262611065;811267;824123;827807;150461;157223;163624;165176.17411912864;174947;1017.3946501831399;1035.7514196592763;1087.0705546757567;1092.9726756831142;1093.2784362320672;20201.494962625464;20511.4872128198;20892.47768805792;21059.368218953456;21086.261980830597;57459.85080298454;60369.698151508965;62930.68534657297;63139.36860631335;64654.67672661607;87431.12568874484;94586;95268;95537;97524;8362.916370836214;8546.786330341543;9072.682456114004;9100.044495327895;9173.40372875761;12285.69285767863;12380.938095309466;13111.885489733098;13581.32093395346;13826.617338266495;9665.71002869915;11225.887741122811;11269.380184089627;11572.363520006144;11795.233309834834;10984.90150984895;11010.889891100986;11158.386288754196;11420.143489238506;11609.071274298205;10972.835407469054;11308.886911130783;11684.357360344922;11757.706057348634;11836.763264734485;8504.53225072627;8579.828403431771;8732.083131271125;8796.868046979173;8805.075467075865;8526.019507756688;10422.895771042193;11323.207375483966;11806.586769463027;11839.34883581377 04:44:54 INFO - PROCESS | 2210 | |3;mootools.html;1356.348952502798;1455.3741890986878;1474.1891959422317;1485.6582985913237;1487.4793822162237;7609.8478030439355;8263.83472330553;8419.36854735895;8505.659773609048;8617.267532259766;8389.790255243623;8460.788480287996;8462.703805366813;8478.236958673719;8490.91509084909;2134.1676746069047;2213.8339624528144;2362.610169322064;2405.434722840131;2408.0127147869375;1840.8895466272;2103.053625868358;2351.5532048910654;2445.8899349529224;2452.239805660242;2378.8334816562847;2397.9040838366445;2407.277816655005;2409.132712223598;2410.529946660402;2384.1059602649007;2384.9761502384927;2404.701461210944;2404.7475015123423;2410.590199666061;2397.5564520563576;2418.4195793009726;2420.310211589706;2420.491696743686;2422.358075110097;8432.15678432158;8437.282830959315;8476.576171191477;8536.829263414758;8549.358798090168;5131.948680513185;5277.02375060615;5280.445553216895;5280.762365693515;5283.260343551906;2943.632045994251;3290.934181316384;3368.96631033689;3496.5804103507744;3532.2405682778326;1167.6146871532374;1188.6790566546983;1210.1226610707256;1216.2763155922212;1232.2729589542123;8041.833934079585;10266.79466410675;10362.585496580203;10832.133429325635;10951.945240273748;3945.191235796655;4479.148961697332;4701.6003639690325;4765.9046819064115;4789.856304310876;9654.469004204695;9662;9668.419894806335;9689.757756056015;9697.709068727949;5334.4398838122215;5337.946620533823;5340.546053585411;5341.4925582069645;5347.893042139135;4341.717788343748;4524.16302983949;4835.903281934412;4844.685095468783;4930.556249937523;3896.629820167136;3902.6097390261316;3975.960240397559;4023.6781057515327;4024.7383920045104;1275.5280546197966;1284.9036322275867;1286.787680032784;1298.7402519496138;1301.8242537257538;796.2634563029291;908.4276905549461;925.5094799756006;942.7454587261539;959.856021596766;4893.437254715754;5403.108487099663;5414.56514023784;5668.631538949955;5812.534997200214;562.6905202138807;570.4609144358624;580.1008436922752;589.0545674192945;602.4246844263718;3168.3980043792067;3601.4957905893198;3659.524261845943;3794;3942.8619998299923;9035.096490350912;9212.170904618617;9295.58169882357;9319.953400232955;9364.812703745887;9295.860562091573;9303.906960930439;9306.441613503212;9310.72067837966;9347.813043739086;7389.630518474055;7462.291082347277;7468.477206595595;7671.309582137635;7849.4897831640765;5695.202671625892;5701.97364474382;5799.159121927212;5930.881382372242;5936.257967754031;7503;8853.911460885309;9133.497657628894;9394.812103758024;9422.29332800029;9373.390729602554;9402.2948278878;9419.84839556964;9505.334626576074;9530;6686.13080299558;6732.730690772314;6903.1716194057035;7104.715811367488;7256;7878.684852605831;7907.762767116996;7974.880376794469;7983.321417679563;7984.201579842202;6895.967974826039;7077.929220707727;7093.929060709327;7119.679614417467;7161.140663120459;6932.722691092502;6949.548279361826;6950.582965022115;6978.68595913175;7020.543664661781;6347.746090156342;6399.328070552525;6457.67711614408;6462.289148193789;6470.6441145737435;4279.379489973999;4930.285108659296;4953.479884612064;4994.126027945168;5000;4875.268709693432;4892.633052521146;4926.137925862888;5056.165732654071;5065.594752419871 04:44:54 INFO - PROCESS | 2210 | |4;prototype.html;364.5006341312402;371.2463698691657;374.4495591480523;387.4092009685228;387.58334790100633;4909.7545122743895;5205.869853253671;5275.446078161791;5276.419593844674;5338;3934.7048971327195;4352.368906508555;4623.352730617717;5071.543561079502;5159.509846564571;3742.2141350316397;3773.6603705666485;4073.4317287844096;4095.4471146395153;4095.795210239491;3009.6839831817674;3559.6440355964455;3778.282126395976;4091.056748044685;4100.507939047318;3503.597086335066;3742.5883152853166;3919.157381163049;3985.760854348734;4064.6138616831354;3387.3733359328603;3824.8661296854616;4056.4118202860714;4065.57311482296;4110.835566577348;3036.9544456833164;3109.2226943264186;3187.6015498062743;3602.2075143468396;3614.4036234021355;4838.153323168467;5069.442361340287;5075.187969924831;5079.212722028092;5113.795448182105;3882.611738826123;3933.2526819904415;4719.4100737407825;4767.42790865095;4767.68767147933;4639.930401043987;5510.834674959758;5538.280023596906;5546.417626149277;5561.499465048165;3442.5180474733556;3463.480477928306;4022.7988600569856;4031.3113501146418;4051.5948405159543;4658.371119898804;4748.290615378461;5702.401247868956;5795.652260864362;5821.708914554255;3227;3827.5215598050245;3833.217553837423;3844.2888065707934;3849;3227.128675257667;3800.054957408031;3880.341965753468;3903.590123037097;3926.3521518949055;3797.867074652374;4004.8197831097086;4537.931931021038;4624.375709279271;4625.213713668684;4907.950920490821;5218.608604354688;5550.861228469321;5581.386047534768;5628.859278517988;1111.2276967507667;1205.409349418796;1231.2612432540404;1285.5950375631833;1301.73965206959;749.6776386153897;838.522042435818;846.3525403066659;852.8379607874608;870.637452387025;4221.741368367909;4823.7791932059445;4865.245886887467;4902.754862256873;5000.224965130411;4744.7390393528685;5236;5294.7617357219015;5345.973270133624;5359;4017.216642754693;4397.626201772885;4828.7102773833685;4895.804167833318;5137.820176293886;2311.7572654870996;2526.4694414172864;2806.733360330765;2806.943861122766;2816.169230077132;5128.256402821645;5177.197534382177;5522.895420915833;5556.916401301788;5594.664320140804;4567.429071366079;4663.696859704176;5049.181286264767;5266;5412.675239485643;4811;5267.789288428497;5498.697571633598;5541.7808082221845;5550.888982220333;4726.598239149711;4852.975735121443;5035.521625445577;5267.420583735862;5444;5067.265246539305;5105.617078719037;5259.500347466985;5399.165438145005;5410.729463526886;5244.921326180187;5815.2149459822385;5831.766729330949;5865.384134665798;5880.382559831327;3708.647678470541;4009.195861862115;4196.727212731163;4217.878769710331;4232.174725928538;4817.927731084106;5412.594055445778;5603.243562119062;5610.803621873215;5619.690916999604;4751.928721069117;4965.553100220997;5205.479452054916;5349.358077030781;5516.172574113915;4807.230843065093;5455.562995312927;5507.146392309199;5512.9877594676855;5561.944380556142;4256.616904478612;4723.574878260973;4839.249916262985;4895.730734809477;5492.203630473638;4321.632661223831;5368.570514358764;5419.891602168013;5448.83653490396;5511.53151982086;5414.159185876821;5415.702136382537;5441.938821929686;5443.374011988672;5463.705243797694 04:44:54 INFO - PROCESS | 2210 | |5;yui.html;741.7663436017657;760.3347071312602;790.2176844923524;847.9448835825671;863.3222920007795;15430.996985195969;15702.723105149746;15741.291641876114;15802;15826.366945322188;14686.412543498247;14709.043912145704;14817.851821481781;14901.850981490183;14916;717.8241330873917;738.7783664900535;746.1754760989111;893.852514335134;903.5211337990876;739.2422766664158;743.6021728375321;744.635128786896;866.8959724833029;897.1835629577087;950.4582388038821;952.6713283917038;956.3210120814231;960.7357976556433;965.7295957131979;956.516958935733;957.1672644798999;957.238994998974;958.094600602431;959.9808003839954;684.1448189762797;690.9689063992132;698.9864696190544;718.5796309159148;721.7365661533555;15428.768568471482;15722.68554628901;15769.842301577068;15925.362985480568;16211.432599859067;14620.97653164279;14779.26103694811;15036.398544058224;15044;15247.542573722805;11655.19547607525;11666.442139296827;11852.40737963107;12354.567590134302;12434.75130497385;3811.790351530665;3837.1558257183374;3846.788426636562;4046;4070.124923141509;108444.4577777114;112540;113244;114856;115088.99999999916;10345.379277243239;11322.32066076038;11490.368029758443;11864.584739534075;11901.702457438634;21877.562448750938;23811.047558097827;24079.157229497236;24167.033318667058;24348.269551913472;8009.599520023976;8018.879716804253;8025.438219324591;8100.149484304181;8215.753527394188;4189.664826813848;4194.916101677949;4286.39990401344;4361.367601697736;4462.888427789331;3702.333579955634;3710.703143748494;3817.6182381762155;3819.197968426606;3837.213371258885;577.4283459375189;677.6075165534775;687.3847906123991;697.5361384679131;700.9544379615309;680.0313093594018;698.7240040184099;705.5131958948309;718.989215161773;774.5314084978506;10165.339252948535;10453.027849417325;10633.893661063445;10767.6231331903;10836.94581527103;636.920384951881;652.3150691773714;702.304718328861;713.1157364867527;746.9691825281077;5023.773930173151;5159.613029022838;5165;5171.534561889448;5183.300254465675;113553.43223283831;116635;117965;118260;120610.39694801469;89841.55079224693;93693.0630693698;95332.52333738287;97742.51128744453;98021.15830733524;86896;88434.55782721174;88814;89587;91094.54452727959;9809.3296558341;9863.309568330147;9876.40741555509;9965;9983.101520863158;42100.57899420967;50513;51680.74159629178;52034.95930081453;52956.73521632367;68562.65718671575;69767.2558186029;71215.57568848491;71369;71510.64244678743;10358.637447689294;11817.704557386134;11857.525698971944;11908.880911191123;11912.285262884254;12521.248725076524;12657.240565566095;12794.808077879026;13012;13787.965902557147;11853.466594003117;12246.816297755362;12418.316992565135;12634.620961371174;12832.101752877208;11812.114091443003;12102.152849300464;12263.69340766488;12382.690432739253;12758.872411275768;11486.310821350746;11981.28112313264;11982.820257696316;12003.879961200277;12143;9937.701868943943;10582.868626972824;10599.470026498799;10674.946625266824;10808.729781755519;8160.918390816016;9398.34211605181;10119.494025298558;10143;10259.589616415558 04:44:54 INFO - PROCESS | 2210 | __end_tp_report 04:44:54 INFO - PROCESS | 2210 | __start_cc_report 04:44:54 INFO - PROCESS | 2210 | _x_x_mozilla_cycle_collect,1572 04:44:54 INFO - PROCESS | 2210 | __end_cc_report 04:44:54 INFO - PROCESS | 2210 | __startTimestamp1490096694383__endTimestamp 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | ------- Summary: start ------- 04:44:54 INFO - PROCESS | 2210 | Number of tests: 6 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#0] dojo.html Cycles:165 Average:5832.00 Median:6117.83 stddev:652.14 (10.7%) stddev-sans-first:612.70 04:44:54 INFO - PROCESS | 2210 | Values: 2915.9 3445.6 3458.7 3501.3 3501.7 5823.7 5828.7 5832.8 5844.2 5852.7 5831.9 5854.9 5909.3 5909.6 5939.4 5226.7 5274.1 5320.7 5321.4 5352.3 5223.2 5257.2 5258.7 5380.0 5394.4 5287.5 5318.7 5320.4 5342.3 5386.6 5355.9 5361.1 5362.5 5365.8 5375.4 5210.8 5217.3 5219.2 5280.8 5352.3 5806.1 5807.4 5895.7 5921.1 5971.1 6205.8 6222.5 6225.1 6227.0 6247.4 6232.3 6264.8 6290.0 6314.1 6321.8 5004.7 5897.9 5903.8 5924.7 5984.5 6328.1 6332.8 6333.3 6340.9 6363.4 6244.2 6276.2 6276.8 6284.7 6293.6 6223.6 6229.8 6289.0 6295.4 6310.5 5160.4 5292.9 6315.1 6340.0 6340.7 6280.7 6322.2 6339.5 6347.4 6358.2 4991.9 5021.5 5048.7 5104.3 5125.9 4542.7 4550.7 4577.6 4581.8 4582.4 5861.6 6001.2 6004.8 6009.6 6017.3 6265.9 6266.5 6271.4 6279.4 6285.5 5821.9 5882.1 5917.0 5955.1 5968.3 4598.8 5394.5 5421.6 5493.3 5558.4 6298.7 6387.1 6389.6 6398.6 6400.0 6243.0 6275.3 6295.1 6305.6 6317.8 6230.9 6275.8 6378.8 6378.9 6396.5 5789.4 6253.9 6270.8 6332.6 6348.0 6312.7 6335.6 6342.3 6362.3 6372.3 6129.8 6142.0 6213.2 6245.3 6281.6 6186.2 6198.7 6256.9 6262.1 6280.4 6165.6 6171.7 6180.7 6187.4 6195.8 6039.2 6284.4 6288.3 6295.4 6302.3 6003.7 6091.4 6104.5 6117.8 6158.7 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#1] ext.html Cycles:180 Average:70980.28 Median:39553.50 stddev:149916.25 (379.0%) stddev-sans-first:150243.29 04:44:54 INFO - PROCESS | 2210 | Values: 455.8 486.2 488.0 504.4 535.9 28422.6 42668.9 44281.1 44457.6 46193.1 45946.3 46547.8 46609.5 46696.8 46706.5 9713.2 9910.5 9915.8 9929.9 9941.1 8644.9 9143.2 11136.4 12151.0 12174.3 11906.3 11921.5 12165.1 12210.0 12241.4 12147.2 12237.3 12255.4 12267.0 12278.2 12091.7 12192.9 12194.2 12197.9 12209.6 43033.4 43434.8 43442.6 43527.6 43622.0 4074.1 4106.2 4125.5 4139.1 4170.7 31214.7 31962.0 32323.8 33403.2 33690.7 3100.0 3119.1 3132.5 3147.2 3190.0 505163.0 506592.0 506817.0 507363.0 507952.0 66305.3 66611.7 66667.0 66719.7 66726.7 68923.7 68963.3 69074.3 69193.0 69198.7 17927.7 18128.2 18141.5 18149.9 18151.8 12679.9 13840.9 14015.9 14015.9 14023.2 15301.5 15724.3 17080.6 17499.3 17540.6 5631.6 6036.6 6573.9 6595.7 6617.2 830.5 878.8 881.1 918.3 927.7 28141.9 30605.8 30767.9 30834.1 31468.7 1045.7 1067.6 1069.1 1091.5 1124.0 15846.4 16028.4 16042.5 16178.4 16419.0 549907.0 552730.2 553626.0 557017.0 560096.0 51150.0 55759.9 56953.4 62747.7 64351.7 1391.9 1443.8 1447.3 1455.9 1457.2 30460.8 31901.5 32165.8 32768.3 33021.8 53025.5 53709.7 54011.0 54284.5 54374.0 589758.0 620204.0 620474.0 630654.0 641634.0 39463.0 40465.4 40725.6 40831.6 40896.0 46184.8 47214.5 47630.8 47844.0 48756.8 37399.6 38653.0 38834.6 39144.0 40240.8 38346.6 38501.8 39644.0 39754.0 39841.0 29282.6 37497.6 37631.4 37965.4 38198.4 31041.5 33567.5 34155.5 34204.7 34630.5 22622.3 25019.0 25128.6 25302.5 25599.7 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#2] jquery.html Cycles:180 Average:42707.10 Median:22340.11 stddev:132269.23 (592.1%) stddev-sans-first:132602.11 04:44:54 INFO - PROCESS | 2210 | Values: 393.5 401.9 411.0 417.1 437.7 20938.0 21026.3 22320.9 22359.3 22956.0 13770.0 22151.7 22246.9 23033.8 23222.0 5469.9 5712.8 5722.2 5740.1 5746.1 5540.0 5639.6 5644.2 6110.0 6190.8 6162.8 6165.1 6174.3 6175.9 6177.9 5930.5 6129.5 6155.1 6187.2 6203.2 5385.1 5533.3 5535.9 5550.2 5552.7 13701.9 14265.2 14286.9 14288.9 14292.1 2670.6 2688.5 2707.0 2738.9 2796.9 9270.3 10714.4 10985.3 15073.3 15926.7 1868.0 1906.5 1970.6 1978.9 2100.9 121899.0 128961.4 140259.0 140880.6 147290.3 12016.8 12265.8 12329.3 12345.4 12841.5 16916.7 16965.3 16973.6 16978.2 17008.7 9159.9 9361.1 9438.6 9556.1 9582.7 8353.3 8671.3 8766.4 8959.6 9158.4 4934.8 5016.3 5020.3 5120.2 5122.9 1720.8 2083.8 2092.7 2093.5 2106.5 884.8 992.4 996.7 1012.4 1047.5 18808.6 22435.0 23005.3 23070.9 23099.7 1047.6 1053.2 1054.7 1065.0 1067.7 11191.3 11532.2 11758.1 11832.6 11842.8 693803.9 804915.9 811267.0 824123.0 827807.0 150461.0 157223.0 163624.0 165176.2 174947.0 1017.4 1035.8 1087.1 1093.0 1093.3 20201.5 20511.5 20892.5 21059.4 21086.3 57459.9 60369.7 62930.7 63139.4 64654.7 87431.1 94586.0 95268.0 95537.0 97524.0 8362.9 8546.8 9072.7 9100.0 9173.4 12285.7 12380.9 13111.9 13581.3 13826.6 9665.7 11225.9 11269.4 11572.4 11795.2 10984.9 11010.9 11158.4 11420.1 11609.1 10972.8 11308.9 11684.4 11757.7 11836.8 8504.5 8579.8 8732.1 8796.9 8805.1 8526.0 10422.9 11323.2 11806.6 11839.3 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#3] mootools.html Cycles:180 Average:5382.08 Median:5408.84 stddev:2892.74 (53.5%) stddev-sans-first:2885.03 04:44:54 INFO - PROCESS | 2210 | Values: 1356.3 1455.4 1474.2 1485.7 1487.5 7609.8 8263.8 8419.4 8505.7 8617.3 8389.8 8460.8 8462.7 8478.2 8490.9 2134.2 2213.8 2362.6 2405.4 2408.0 1840.9 2103.1 2351.6 2445.9 2452.2 2378.8 2397.9 2407.3 2409.1 2410.5 2384.1 2385.0 2404.7 2404.7 2410.6 2397.6 2418.4 2420.3 2420.5 2422.4 8432.2 8437.3 8476.6 8536.8 8549.4 5131.9 5277.0 5280.4 5280.8 5283.3 2943.6 3290.9 3369.0 3496.6 3532.2 1167.6 1188.7 1210.1 1216.3 1232.3 8041.8 10266.8 10362.6 10832.1 10951.9 3945.2 4479.1 4701.6 4765.9 4789.9 9654.5 9662.0 9668.4 9689.8 9697.7 5334.4 5337.9 5340.5 5341.5 5347.9 4341.7 4524.2 4835.9 4844.7 4930.6 3896.6 3902.6 3976.0 4023.7 4024.7 1275.5 1284.9 1286.8 1298.7 1301.8 796.3 908.4 925.5 942.7 959.9 4893.4 5403.1 5414.6 5668.6 5812.5 562.7 570.5 580.1 589.1 602.4 3168.4 3601.5 3659.5 3794.0 3942.9 9035.1 9212.2 9295.6 9320.0 9364.8 9295.9 9303.9 9306.4 9310.7 9347.8 7389.6 7462.3 7468.5 7671.3 7849.5 5695.2 5702.0 5799.2 5930.9 5936.3 7503.0 8853.9 9133.5 9394.8 9422.3 9373.4 9402.3 9419.8 9505.3 9530.0 6686.1 6732.7 6903.2 7104.7 7256.0 7878.7 7907.8 7974.9 7983.3 7984.2 6896.0 7077.9 7093.9 7119.7 7161.1 6932.7 6949.5 6950.6 6978.7 7020.5 6347.7 6399.3 6457.7 6462.3 6470.6 4279.4 4930.3 4953.5 4994.1 5000.0 4875.3 4892.6 4926.1 5056.2 5065.6 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#4] prototype.html Cycles:180 Average:4350.60 Median:4826.24 stddev:1326.58 (27.5%) stddev-sans-first:1296.13 04:44:54 INFO - PROCESS | 2210 | Values: 364.5 371.2 374.4 387.4 387.6 4909.8 5205.9 5275.4 5276.4 5338.0 3934.7 4352.4 4623.4 5071.5 5159.5 3742.2 3773.7 4073.4 4095.4 4095.8 3009.7 3559.6 3778.3 4091.1 4100.5 3503.6 3742.6 3919.2 3985.8 4064.6 3387.4 3824.9 4056.4 4065.6 4110.8 3037.0 3109.2 3187.6 3602.2 3614.4 4838.2 5069.4 5075.2 5079.2 5113.8 3882.6 3933.3 4719.4 4767.4 4767.7 4639.9 5510.8 5538.3 5546.4 5561.5 3442.5 3463.5 4022.8 4031.3 4051.6 4658.4 4748.3 5702.4 5795.7 5821.7 3227.0 3827.5 3833.2 3844.3 3849.0 3227.1 3800.1 3880.3 3903.6 3926.4 3797.9 4004.8 4537.9 4624.4 4625.2 4908.0 5218.6 5550.9 5581.4 5628.9 1111.2 1205.4 1231.3 1285.6 1301.7 749.7 838.5 846.4 852.8 870.6 4221.7 4823.8 4865.2 4902.8 5000.2 4744.7 5236.0 5294.8 5346.0 5359.0 4017.2 4397.6 4828.7 4895.8 5137.8 2311.8 2526.5 2806.7 2806.9 2816.2 5128.3 5177.2 5522.9 5556.9 5594.7 4567.4 4663.7 5049.2 5266.0 5412.7 4811.0 5267.8 5498.7 5541.8 5550.9 4726.6 4853.0 5035.5 5267.4 5444.0 5067.3 5105.6 5259.5 5399.2 5410.7 5244.9 5815.2 5831.8 5865.4 5880.4 3708.6 4009.2 4196.7 4217.9 4232.2 4817.9 5412.6 5603.2 5610.8 5619.7 4751.9 4965.6 5205.5 5349.4 5516.2 4807.2 5455.6 5507.1 5513.0 5561.9 4256.6 4723.6 4839.2 4895.7 5492.2 4321.6 5368.6 5419.9 5448.8 5511.5 5414.2 5415.7 5441.9 5443.4 5463.7 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - PROCESS | 2210 | [#5] yui.html Cycles:180 Average:21577.49 Median:4058.06 stddev:32258.76 (794.9%) stddev-sans-first:32311.32 04:44:54 INFO - PROCESS | 2210 | Values: 741.8 760.3 790.2 847.9 863.3 15431.0 15702.7 15741.3 15802.0 15826.4 14686.4 14709.0 14817.9 14901.9 14916.0 717.8 738.8 746.2 893.9 903.5 739.2 743.6 744.6 866.9 897.2 950.5 952.7 956.3 960.7 965.7 956.5 957.2 957.2 958.1 960.0 684.1 691.0 699.0 718.6 721.7 15428.8 15722.7 15769.8 15925.4 16211.4 14621.0 14779.3 15036.4 15044.0 15247.5 11655.2 11666.4 11852.4 12354.6 12434.8 3811.8 3837.2 3846.8 4046.0 4070.1 108444.5 112540.0 113244.0 114856.0 115089.0 10345.4 11322.3 11490.4 11864.6 11901.7 21877.6 23811.0 24079.2 24167.0 24348.3 8009.6 8018.9 8025.4 8100.1 8215.8 4189.7 4194.9 4286.4 4361.4 4462.9 3702.3 3710.7 3817.6 3819.2 3837.2 577.4 677.6 687.4 697.5 701.0 680.0 698.7 705.5 719.0 774.5 10165.3 10453.0 10633.9 10767.6 10836.9 636.9 652.3 702.3 713.1 747.0 5023.8 5159.6 5165.0 5171.5 5183.3 113553.4 116635.0 117965.0 118260.0 120610.4 89841.6 93693.1 95332.5 97742.5 98021.2 86896.0 88434.6 88814.0 89587.0 91094.5 9809.3 9863.3 9876.4 9965.0 9983.1 42100.6 50513.0 51680.7 52035.0 52956.7 68562.7 69767.3 71215.6 71369.0 71510.6 10358.6 11817.7 11857.5 11908.9 11912.3 12521.2 12657.2 12794.8 13012.0 13788.0 11853.5 12246.8 12418.3 12634.6 12832.1 11812.1 12102.2 12263.7 12382.7 12758.9 11486.3 11981.3 11982.8 12003.9 12143.0 9937.7 10582.9 10599.5 10674.9 10808.7 8160.9 9398.3 10119.5 10143.0 10259.6 04:44:54 INFO - PROCESS | 2210 | -------- Summary: end -------- 04:44:54 INFO - PROCESS | 2210 | 04:44:54 INFO - TEST-INFO | 2210: exit 0 04:44:54 INFO - TEST-OK | dromaeo_css | took 1116257ms 04:44:54 INFO - TEST-START | kraken 04:44:54 INFO - operating with platform_type : mac_ 04:44:54 INFO - Initialising browser for kraken test... 04:44:55 INFO - TEST-INFO | started process 2215 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpubVu24/profile http://localhost:57537/getInfo.html) 04:44:57 INFO - PROCESS | 2215 | __metrics Screen width/height:1600/1200 04:44:57 INFO - PROCESS | 2215 | colorDepth:24 04:44:57 INFO - PROCESS | 2215 | Browser inner width/height: 1024/689 04:44:57 INFO - PROCESS | 2215 | __metrics 04:44:57 INFO - PROCESS | 2215 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:57 INFO - PROCESS | 2215 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:58 INFO - TEST-INFO | 2215: exit 0 04:44:58 INFO - Browser initialized. 04:44:58 INFO - Running cycle 1/1 for kraken test... 04:44:58 INFO - TEST-INFO | started process 2217 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpubVu24/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:09 INFO - PROCESS | 2217 | RSS: Main: 163205120 04:45:09 INFO - PROCESS | 2217 | 04:45:12 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57537/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:13 INFO - PROCESS | 2217 | RSS: Main: 213659648 04:45:13 INFO - PROCESS | 2217 | 04:45:16 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57537/tests/kraken/driver.html?testName=audio-dft) 04:45:16 INFO - PROCESS | 2217 | RSS: Main: 229818368 04:45:16 INFO - PROCESS | 2217 | 04:45:19 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57537/tests/kraken/driver.html?testName=audio-fft) 04:45:20 INFO - PROCESS | 2217 | RSS: Main: 325230592 04:45:20 INFO - PROCESS | 2217 | 04:45:22 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57537/tests/kraken/driver.html?testName=audio-oscillator) 04:45:23 INFO - PROCESS | 2217 | RSS: Main: 228147200 04:45:23 INFO - PROCESS | 2217 | 04:45:25 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:25 INFO - PROCESS | 2217 | RSS: Main: 230707200 04:45:25 INFO - PROCESS | 2217 | 04:45:28 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57537/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:29 INFO - PROCESS | 2217 | RSS: Main: 269754368 04:45:29 INFO - PROCESS | 2217 | 04:45:31 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57537/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:32 INFO - PROCESS | 2217 | RSS: Main: 268857344 04:45:32 INFO - PROCESS | 2217 | 04:45:35 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57537/tests/kraken/driver.html?testName=json-parse-financial) 04:45:35 INFO - PROCESS | 2217 | RSS: Main: 267702272 04:45:35 INFO - PROCESS | 2217 | 04:45:37 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:38 INFO - PROCESS | 2217 | RSS: Main: 244416512 04:45:38 INFO - PROCESS | 2217 | 04:45:39 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:40 INFO - PROCESS | 2217 | RSS: Main: 248549376 04:45:40 INFO - PROCESS | 2217 | 04:45:42 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:43 INFO - PROCESS | 2217 | RSS: Main: 253308928 04:45:43 INFO - PROCESS | 2217 | 04:45:46 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:47 INFO - PROCESS | 2217 | RSS: Main: 260001792 04:45:47 INFO - PROCESS | 2217 | 04:45:49 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:50 INFO - PROCESS | 2217 | RSS: Main: 261320704 04:45:50 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | Cycle 1(1): loaded http://localhost:57537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57537/tests/kraken/driver.html?testName=ai-astar) 04:45:52 INFO - PROCESS | 2217 | RSS: Main: 305512448 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | __start_tp_report 04:45:52 INFO - PROCESS | 2217 | _x_x_mozilla_page_load 04:45:52 INFO - PROCESS | 2217 | _x_x_mozilla_page_load_details 04:45:52 INFO - PROCESS | 2217 | |i|pagename|runs| 04:45:52 INFO - PROCESS | 2217 | |0;ai-astar;102;114;114;111;112;114;113;112;114;112 04:45:52 INFO - PROCESS | 2217 | |1;audio-beat-detection;146;125;140;179;109;109;112;131;159;114 04:45:52 INFO - PROCESS | 2217 | |2;audio-dft;183;182;184;182;182;183;183;183;183;183 04:45:52 INFO - PROCESS | 2217 | |3;audio-fft;82;57;58;90;60;58;57;57;72;58 04:45:52 INFO - PROCESS | 2217 | |4;audio-oscillator;86;70;107;102;98;80;81;67;68;81 04:45:52 INFO - PROCESS | 2217 | |5;imaging-gaussian-blur;86;85;87;84;86;87;87;85;87;83 04:45:52 INFO - PROCESS | 2217 | |6;imaging-darkroom;95;95;95;94;94;94;94;94;93;110 04:45:52 INFO - PROCESS | 2217 | |7;imaging-desaturate;88;85;85;88;87;87;89;85;84;86 04:45:52 INFO - PROCESS | 2217 | |8;json-parse-financial;57;54;55;56;57;58;58;58;56;56 04:45:52 INFO - PROCESS | 2217 | |9;json-stringify-tinderbox;64;73;65;73;70;69;68;67;68;68 04:45:52 INFO - PROCESS | 2217 | |10;stanford-crypto-aes;86;80;83;86;82;90;100;100;88;106 04:45:52 INFO - PROCESS | 2217 | |11;stanford-crypto-ccm;133;133;145;150;132;133;154;154;162;125 04:45:52 INFO - PROCESS | 2217 | |12;stanford-crypto-pbkdf2;162;164;162;163;162;162;161;160;160;161 04:45:52 INFO - PROCESS | 2217 | |13;stanford-crypto-sha256-iterative;83;83;67;65;63;64;63;64;63;63 04:45:52 INFO - PROCESS | 2217 | __end_tp_report 04:45:52 INFO - PROCESS | 2217 | __start_cc_report 04:45:52 INFO - PROCESS | 2217 | _x_x_mozilla_cycle_collect,1900 04:45:52 INFO - PROCESS | 2217 | __end_cc_report 04:45:52 INFO - PROCESS | 2217 | __startTimestamp1490096752419__endTimestamp 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | ------- Summary: start ------- 04:45:52 INFO - PROCESS | 2217 | Number of tests: 14 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:3.61 (3.2%) stddev-sans-first:1.17 04:45:52 INFO - PROCESS | 2217 | Values: 102.0 114.0 114.0 111.0 112.0 114.0 113.0 112.0 114.0 112.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:135.50 stddev:23.64 (17.4%) stddev-sans-first:24.55 04:45:52 INFO - PROCESS | 2217 | Values: 146.0 125.0 140.0 179.0 109.0 109.0 112.0 131.0 159.0 114.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:0.63 (0.3%) stddev-sans-first:0.67 04:45:52 INFO - PROCESS | 2217 | Values: 183.0 182.0 184.0 182.0 182.0 183.0 183.0 183.0 183.0 183.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#3] audio-fft Cycles:10 Average:64.90 Median:59.00 stddev:12.14 (20.6%) stddev-sans-first:11.19 04:45:52 INFO - PROCESS | 2217 | Values: 82.0 57.0 58.0 90.0 60.0 58.0 57.0 57.0 72.0 58.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:80.50 stddev:14.25 (17.7%) stddev-sans-first:15.10 04:45:52 INFO - PROCESS | 2217 | Values: 86.0 70.0 107.0 102.0 98.0 80.0 81.0 67.0 68.0 81.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.42 (1.6%) stddev-sans-first:1.50 04:45:52 INFO - PROCESS | 2217 | Values: 86.0 85.0 87.0 84.0 86.0 87.0 87.0 85.0 87.0 83.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:94.00 stddev:5.03 (5.3%) stddev-sans-first:5.33 04:45:52 INFO - PROCESS | 2217 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 110.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.65 (1.9%) stddev-sans-first:1.64 04:45:52 INFO - PROCESS | 2217 | Values: 88.0 85.0 85.0 88.0 87.0 87.0 89.0 85.0 84.0 86.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 04:45:52 INFO - PROCESS | 2217 | Values: 57.0 54.0 55.0 56.0 57.0 58.0 58.0 58.0 56.0 56.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:2.95 (4.3%) stddev-sans-first:2.65 04:45:52 INFO - PROCESS | 2217 | Values: 64.0 73.0 65.0 73.0 70.0 69.0 68.0 67.0 68.0 68.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:84.50 stddev:8.85 (10.5%) stddev-sans-first:9.26 04:45:52 INFO - PROCESS | 2217 | Values: 86.0 80.0 83.0 86.0 82.0 90.0 100.0 100.0 88.0 106.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:147.50 stddev:12.44 (8.4%) stddev-sans-first:12.75 04:45:52 INFO - PROCESS | 2217 | Values: 133.0 133.0 145.0 150.0 132.0 133.0 154.0 154.0 162.0 125.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 04:45:52 INFO - PROCESS | 2217 | Values: 162.0 164.0 162.0 163.0 162.0 162.0 161.0 160.0 160.0 161.0 04:45:52 INFO - PROCESS | 2217 | 04:45:52 INFO - PROCESS | 2217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:64.50 stddev:8.11 (12.6%) stddev-sans-first:6.47 04:45:52 INFO - PROCESS | 2217 | Values: 83.0 83.0 67.0 65.0 63.0 64.0 63.0 64.0 63.0 63.0 04:45:52 INFO - PROCESS | 2217 | -------- Summary: end -------- 04:45:52 INFO - PROCESS | 2217 | 04:45:53 INFO - TEST-INFO | 2217: exit 0 04:45:53 INFO - TEST-OK | kraken | took 58260ms 04:45:53 INFO - SUITE-END | took 1174s 04:45:53 INFO - Completed test suite (00:19:34) 04:45:53 INFO - javascript benchmark 04:45:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.8542072896357, 3445.5865296164466, 3458.688718015378, 3501.2822371413863, 3501.7023552997994, 5823.65058096514, 5828.679422631753, 5832.8042751236, 5844.152597873311, 5852.736626851792, 5831.854203644911, 5854.853628659275, 5909.320428150764, 5909.586328956974, 5939.435753603411, 5226.660267082628, 5274.077036518594, 5320.654157479771, 5321.414644389114, 5352.277442545245, 5223.190405487156, 5257.1851363038595, 5258.684478931257, 5380.031594313022, 5394.406615272336, 5287.4976877196605, 5318.73406329682, 5320.441353657869, 5342.332208473941, 5386.649867758583, 5355.946440535603, 5361.142217245222, 5362.517373436371, 5365.7585408656705, 5375.43557926416, 5210.843674689765, 5217.34783152106, 5219.217117432378, 5280.788768449257, 5352.330958630171, 5806.129080637938, 5807.361190269067, 5895.675737834417, 5921.141434492018, 5971.0744834550715, 6205.7517699291975, 6222.471089957359, 6225.128482012522, 6227.0, 6247.406496382836, 6232.283287421959, 6264.843378915518, 6290.0, 6314.116023756677, 6321.841953951142, 5004.724740139254, 5897.882042359129, 5903.763849446017, 5924.703764811742, 5984.521238300926, 6328.050792381087, 6332.8416789579705, 6333.334999825044, 6340.873182536324, 6363.427291543783, 6244.1570387997945, 6276.246850377984, 6276.843078922972, 6284.748610055546, 6293.559450838397, 6223.564350495512, 6229.781957631461, 6288.968555157287, 6295.401936816087, 6310.5267104967315, 5160.406553246425, 5292.947070529322, 6315.115883776275, 6340.048992651047, 6340.7463701451425, 6280.654563999024, 6322.241331040213, 6339.461145802658, 6347.428731414195, 6358.23701155855, 4991.850244492671, 5021.548060674557, 5048.747562621854, 5104.259882317043, 5125.948740512622, 4542.727436353829, 4550.658700597469, 4577.61090307321, 4581.79381927814, 4582.358469814229, 5861.6189947653265, 6001.2498437695285, 6004.759809607567, 6009.609375390585, 6017.308009578955, 6265.906011409833, 6266.49868010558, 6271.372862713783, 6279.3720627937755, 6285.528585356116, 5821.854453638693, 5882.117682347682, 5917.0, 5955.136505206808, 5968.283805943314, 4598.770061496912, 5394.460553944574, 5421.566274698014, 5493.285872836505, 5558.388577256498, 6298.7480500780375, 6387.105805187278, 6389.648569328639, 6398.552101352953, 6400.039994000937, 6242.968785156045, 6275.278342990615, 6295.055741638791, 6305.558610897193, 6317.842053948688, 6230.937690623035, 6275.811725648238, 6378.840528986812, 6378.9362106380195, 6396.48828093742, 5789.363170051207, 6253.906191407042, 6270.843228919131, 6332.620042797447, 6347.96826015867, 6312.747490100344, 6335.588186767845, 6342.302346741762, 6362.331955144643, 6372.330905254881, 6129.817282374446, 6142.0, 6213.161223234805, 6245.28179259391, 6281.560290779602, 6186.19579454686, 6198.690065496798, 6256.874862502634, 6262.09199666055, 6280.434760871543, 6165.599236049642, 6171.722272497838, 6180.721867516063, 6187.443130118311, 6195.845103872439, 6039.214902062704, 6284.371562843862, 6288.276848162337, 6295.433410993032, 6302.3067462578165, 6003.669798161143, 6091.390860913873, 6104.481119104926, 6117.825149509824, 6158.7228574715145], "value": 5790.388269604866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.78122501199425, 486.15651844050564, 487.9951200487995, 504.3569448952587, 535.9495389037486, 28422.57366139507, 42668.93327666806, 44281.11437771242, 44457.555424445745, 46193.07613847729, 45946.31080533786, 46547.767261163644, 46609.533904660944, 46696.76651616746, 46706.53293467064, 9713.174380177676, 9910.504474776268, 9915.801683966316, 9929.851052234222, 9941.055599718014, 8644.870326945102, 9143.177114059734, 11136.387498687569, 12151.0, 12174.269543827399, 11906.285622862613, 11921.523139074427, 12165.148439609231, 12210.023198144127, 12241.449134788956, 12147.21043132198, 12237.265764054186, 12255.448504817305, 12267.0, 12278.201916875463, 12091.697707557294, 12192.939035304855, 12194.207376520499, 12197.939010304892, 12209.633710988684, 43033.35449968253, 43434.78282608598, 43442.56557434449, 43527.56472435267, 43622.0, 4074.1311053601453, 4106.1992911382295, 4125.484314460692, 4139.110091330348, 4170.70805043647, 31214.687853121406, 31962.0, 32323.838380807945, 33403.16492087693, 33690.66309336924, 3099.9535006974916, 3119.1110533497845, 3132.4988001919583, 3147.2446612812987, 3189.952150717741, 505163.0, 506592.0, 506817.0, 507362.99999999633, 507952.0, 66305.33694663088, 66611.66694166498, 66667.0, 66719.66640166768, 66726.66636666785, 68923.65538172277, 68963.3103668967, 69074.3092569078, 69193.0, 69198.65400672964, 17927.73108403375, 18128.184231709605, 18141.546461338574, 18149.911005339723, 18151.818481815277, 12679.922206612357, 13840.861591384159, 14015.929920350332, 14015.929920350536, 14023.228722420365, 15301.46444874424, 15724.29240684172, 17080.57298567546, 17499.30002799874, 17540.649187016188, 5631.577631677641, 6036.577439579275, 6573.934260657428, 6595.670216489157, 6617.239017513048, 830.5224495914873, 878.83302172587, 881.0968757024101, 918.2699753695828, 927.7448701607112, 28141.859290703826, 30605.846970765004, 30767.923122690598, 30834.074977750704, 31468.685313147034, 1045.7281106912258, 1067.64767626683, 1069.1286601419818, 1091.4542728635681, 1123.994380028111, 15846.449825058027, 16028.358865645243, 16042.518724438285, 16178.352865885468, 16419.01485910849, 549907.0, 552730.2363488157, 553626.0, 557017.0, 560096.0, 51150.0, 55759.88480230373, 56953.430465694815, 62747.6862615684, 64351.67824160943, 1391.8608139186204, 1443.7906503556715, 1447.3125265498804, 1455.9126452412888, 1457.1912588513264, 30460.84769576138, 31901.521477177397, 32165.839170803996, 32768.344633107685, 33021.83489082539, 53025.469745302056, 53709.73145134249, 54011.0, 54284.45715542794, 54374.0, 589758.0, 620204.0, 620474.0, 630654.0, 641634.0, 39463.0, 40465.39301910532, 40725.592744073365, 40831.59168408278, 40896.0, 46184.84336409739, 47214.527854722386, 47630.761846190544, 47844.0, 48756.756216218695, 37399.626003740705, 38653.0, 38834.61165388423, 39143.95026303231, 40240.79277621676, 38346.61653383542, 38501.80749096237, 39644.008899777735, 39754.0, 39841.0, 29282.560761588167, 37497.6250237505, 37631.43552846655, 37965.43051854169, 38198.427023594115, 31041.534376984815, 33567.49648755222, 34155.48766768451, 34204.657953420145, 34630.480542792386, 22622.321330360115, 25018.999240030196, 25128.617926013514, 25302.49395012126, 25599.74400256048], "value": 21014.9031796702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.470781798481, 401.91683413201395, 410.99589004109947, 417.12195827782506, 437.7045494291352, 20937.95310234488, 21026.264080757177, 22320.88839555804, 22359.32922012338, 22956.0, 13770.0, 22151.667724984138, 22246.887655617236, 23033.769662303373, 23222.0, 5469.863253418666, 5712.828615141552, 5722.227499287585, 5740.1102829061565, 5746.051901436279, 5540.0, 5639.6334238274585, 5644.238027866227, 6110.0, 6190.81427557174, 6162.7534898604, 6165.136880836686, 6174.289956654975, 6175.938240617604, 6177.938220617782, 5930.466258036776, 6129.509639228851, 6155.138280640714, 6187.16473276111, 6203.2245969253845, 5385.111456609655, 5533.3083364579425, 5535.889282214333, 5550.16747487876, 5552.69460179694, 13701.86298137016, 14265.215413152273, 14286.928480363911, 14288.85711142896, 14292.071015383966, 2670.639463672399, 2688.4891870544534, 2706.9593956090675, 2738.931526711828, 2796.9440611187865, 9270.258379329638, 10714.410707411089, 10985.285956412887, 15073.332833620712, 15926.681466370723, 1867.9626407471774, 1906.4661894669514, 1970.5763260898975, 1978.8515861310316, 2100.915963361479, 121899.0, 128961.35519322437, 140259.0, 140880.59119408778, 147290.26354868265, 12016.759664806656, 12265.816012759815, 12329.349189924209, 12345.382730863601, 12841.48634054646, 16916.661666766595, 16965.321387144377, 16973.575660608585, 16978.151092445576, 17008.744868826976, 9159.862602060974, 9361.110694484014, 9438.622455101857, 9556.092171243721, 9582.66460673873, 8353.289970352467, 8671.262942649819, 8766.430182038275, 8959.5968181432, 9158.358914876027, 4934.777934992934, 5016.297718319438, 5020.322256495327, 5120.231965205175, 5122.871928201825, 1720.8279172082691, 2083.802038806311, 2092.6756352765346, 2093.5184907471366, 2106.462851972737, 884.75669190973, 992.4095163377779, 996.6960077176531, 1012.3824467075078, 1047.486731501574, 18808.623827523374, 22435.0, 23005.309840704806, 23070.884645576665, 23099.653505197435, 1047.617619568852, 1053.2311412668641, 1054.7204990677476, 1064.9627263045757, 1067.690369792767, 11191.328520288645, 11532.192746507664, 11758.05935525156, 11832.645020649394, 11842.76314473723, 693803.8502288903, 804915.9262611065, 811267.0, 824123.0, 827807.0, 150461.0, 157223.0, 163624.0, 165176.17411912864, 174947.0, 1017.3946501831399, 1035.7514196592763, 1087.0705546757567, 1092.9726756831142, 1093.2784362320672, 20201.494962625464, 20511.4872128198, 20892.47768805792, 21059.368218953456, 21086.261980830597, 57459.85080298454, 60369.698151508965, 62930.68534657297, 63139.36860631335, 64654.67672661607, 87431.12568874484, 94586.0, 95268.0, 95537.0, 97524.0, 8362.916370836214, 8546.786330341543, 9072.682456114004, 9100.044495327895, 9173.40372875761, 12285.69285767863, 12380.938095309466, 13111.885489733098, 13581.32093395346, 13826.617338266495, 9665.71002869915, 11225.887741122811, 11269.380184089627, 11572.363520006144, 11795.233309834834, 10984.90150984895, 11010.889891100986, 11158.386288754196, 11420.143489238506, 11609.071274298205, 10972.835407469054, 11308.886911130783, 11684.357360344922, 11757.706057348634, 11836.763264734485, 8504.53225072627, 8579.828403431771, 8732.083131271125, 8796.868046979173, 8805.075467075865, 8526.019507756688, 10422.895771042193, 11323.207375483966, 11806.586769463027, 11839.34883581377], "value": 10197.505210514944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.348952502798, 1455.3741890986878, 1474.1891959422317, 1485.6582985913237, 1487.4793822162237, 7609.8478030439355, 8263.83472330553, 8419.36854735895, 8505.659773609048, 8617.267532259766, 8389.790255243623, 8460.788480287996, 8462.703805366813, 8478.236958673719, 8490.91509084909, 2134.1676746069047, 2213.8339624528144, 2362.610169322064, 2405.434722840131, 2408.0127147869375, 1840.8895466272, 2103.053625868358, 2351.5532048910654, 2445.8899349529224, 2452.239805660242, 2378.8334816562847, 2397.9040838366445, 2407.277816655005, 2409.132712223598, 2410.529946660402, 2384.1059602649007, 2384.9761502384927, 2404.701461210944, 2404.7475015123423, 2410.590199666061, 2397.5564520563576, 2418.4195793009726, 2420.310211589706, 2420.491696743686, 2422.358075110097, 8432.15678432158, 8437.282830959315, 8476.576171191477, 8536.829263414758, 8549.358798090168, 5131.948680513185, 5277.02375060615, 5280.445553216895, 5280.762365693515, 5283.260343551906, 2943.632045994251, 3290.934181316384, 3368.96631033689, 3496.5804103507744, 3532.2405682778326, 1167.6146871532374, 1188.6790566546983, 1210.1226610707256, 1216.2763155922212, 1232.2729589542123, 8041.833934079585, 10266.79466410675, 10362.585496580203, 10832.133429325635, 10951.945240273748, 3945.191235796655, 4479.148961697332, 4701.6003639690325, 4765.9046819064115, 4789.856304310876, 9654.469004204695, 9662.0, 9668.419894806335, 9689.757756056015, 9697.709068727949, 5334.4398838122215, 5337.946620533823, 5340.546053585411, 5341.4925582069645, 5347.893042139135, 4341.717788343748, 4524.16302983949, 4835.903281934412, 4844.685095468783, 4930.556249937523, 3896.629820167136, 3902.6097390261316, 3975.960240397559, 4023.6781057515327, 4024.7383920045104, 1275.5280546197966, 1284.9036322275867, 1286.787680032784, 1298.7402519496138, 1301.8242537257538, 796.2634563029291, 908.4276905549461, 925.5094799756006, 942.7454587261539, 959.856021596766, 4893.437254715754, 5403.108487099663, 5414.56514023784, 5668.631538949955, 5812.534997200214, 562.6905202138807, 570.4609144358624, 580.1008436922752, 589.0545674192945, 602.4246844263718, 3168.3980043792067, 3601.4957905893198, 3659.524261845943, 3794.0, 3942.8619998299923, 9035.096490350912, 9212.170904618617, 9295.58169882357, 9319.953400232955, 9364.812703745887, 9295.860562091573, 9303.906960930439, 9306.441613503212, 9310.72067837966, 9347.813043739086, 7389.630518474055, 7462.291082347277, 7468.477206595595, 7671.309582137635, 7849.4897831640765, 5695.202671625892, 5701.97364474382, 5799.159121927212, 5930.881382372242, 5936.257967754031, 7503.0, 8853.911460885309, 9133.497657628894, 9394.812103758024, 9422.29332800029, 9373.390729602554, 9402.2948278878, 9419.84839556964, 9505.334626576074, 9530.0, 6686.13080299558, 6732.730690772314, 6903.1716194057035, 7104.715811367488, 7256.0, 7878.684852605831, 7907.762767116996, 7974.880376794469, 7983.321417679563, 7984.201579842202, 6895.967974826039, 7077.929220707727, 7093.929060709327, 7119.679614417467, 7161.140663120459, 6932.722691092502, 6949.548279361826, 6950.582965022115, 6978.68595913175, 7020.543664661781, 6347.746090156342, 6399.328070552525, 6457.67711614408, 6462.289148193789, 6470.6441145737435, 4279.379489973999, 4930.285108659296, 4953.479884612064, 4994.126027945168, 5000.0, 4875.268709693432, 4892.633052521146, 4926.137925862888, 5056.165732654071, 5065.594752419871], "value": 4356.778025563947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.5006341312402, 371.2463698691657, 374.4495591480523, 387.4092009685228, 387.58334790100633, 4909.7545122743895, 5205.869853253671, 5275.446078161791, 5276.419593844674, 5338.0, 3934.7048971327195, 4352.368906508555, 4623.352730617717, 5071.543561079502, 5159.509846564571, 3742.2141350316397, 3773.6603705666485, 4073.4317287844096, 4095.4471146395153, 4095.795210239491, 3009.6839831817674, 3559.6440355964455, 3778.282126395976, 4091.056748044685, 4100.507939047318, 3503.597086335066, 3742.5883152853166, 3919.157381163049, 3985.760854348734, 4064.6138616831354, 3387.3733359328603, 3824.8661296854616, 4056.4118202860714, 4065.57311482296, 4110.835566577348, 3036.9544456833164, 3109.2226943264186, 3187.6015498062743, 3602.2075143468396, 3614.4036234021355, 4838.153323168467, 5069.442361340287, 5075.187969924831, 5079.212722028092, 5113.795448182105, 3882.611738826123, 3933.2526819904415, 4719.4100737407825, 4767.42790865095, 4767.68767147933, 4639.930401043987, 5510.834674959758, 5538.280023596906, 5546.417626149277, 5561.499465048165, 3442.5180474733556, 3463.480477928306, 4022.7988600569856, 4031.3113501146418, 4051.5948405159543, 4658.371119898804, 4748.290615378461, 5702.401247868956, 5795.652260864362, 5821.708914554255, 3227.0, 3827.5215598050245, 3833.217553837423, 3844.2888065707934, 3849.0, 3227.128675257667, 3800.054957408031, 3880.341965753468, 3903.590123037097, 3926.3521518949055, 3797.867074652374, 4004.8197831097086, 4537.931931021038, 4624.375709279271, 4625.213713668684, 4907.950920490821, 5218.608604354688, 5550.861228469321, 5581.386047534768, 5628.859278517988, 1111.2276967507667, 1205.409349418796, 1231.2612432540404, 1285.5950375631833, 1301.73965206959, 749.6776386153897, 838.522042435818, 846.3525403066659, 852.8379607874608, 870.637452387025, 4221.741368367909, 4823.7791932059445, 4865.245886887467, 4902.754862256873, 5000.224965130411, 4744.7390393528685, 5236.0, 5294.7617357219015, 5345.973270133624, 5359.0, 4017.216642754693, 4397.626201772885, 4828.7102773833685, 4895.804167833318, 5137.820176293886, 2311.7572654870996, 2526.4694414172864, 2806.733360330765, 2806.943861122766, 2816.169230077132, 5128.256402821645, 5177.197534382177, 5522.895420915833, 5556.916401301788, 5594.664320140804, 4567.429071366079, 4663.696859704176, 5049.181286264767, 5266.0, 5412.675239485643, 4811.0, 5267.789288428497, 5498.697571633598, 5541.7808082221845, 5550.888982220333, 4726.598239149711, 4852.975735121443, 5035.521625445577, 5267.420583735862, 5444.0, 5067.265246539305, 5105.617078719037, 5259.500347466985, 5399.165438145005, 5410.729463526886, 5244.921326180187, 5815.2149459822385, 5831.766729330949, 5865.384134665798, 5880.382559831327, 3708.647678470541, 4009.195861862115, 4196.727212731163, 4217.878769710331, 4232.174725928538, 4817.927731084106, 5412.594055445778, 5603.243562119062, 5610.803621873215, 5619.690916999604, 4751.928721069117, 4965.553100220997, 5205.479452054916, 5349.358077030781, 5516.172574113915, 4807.230843065093, 5455.562995312927, 5507.146392309199, 5512.9877594676855, 5561.944380556142, 4256.616904478612, 4723.574878260973, 4839.249916262985, 4895.730734809477, 5492.203630473638, 4321.632661223831, 5368.570514358764, 5419.891602168013, 5448.83653490396, 5511.53151982086, 5414.159185876821, 5415.702136382537, 5441.938821929686, 5443.374011988672, 5463.705243797694], "value": 3948.304659182808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.7663436017657, 760.3347071312602, 790.2176844923524, 847.9448835825671, 863.3222920007795, 15430.996985195969, 15702.723105149746, 15741.291641876114, 15802.0, 15826.366945322188, 14686.412543498247, 14709.043912145704, 14817.851821481781, 14901.850981490183, 14916.0, 717.8241330873917, 738.7783664900535, 746.1754760989111, 893.852514335134, 903.5211337990876, 739.2422766664158, 743.6021728375321, 744.635128786896, 866.8959724833029, 897.1835629577087, 950.4582388038821, 952.6713283917038, 956.3210120814231, 960.7357976556433, 965.7295957131979, 956.516958935733, 957.1672644798999, 957.238994998974, 958.094600602431, 959.9808003839954, 684.1448189762797, 690.9689063992132, 698.9864696190544, 718.5796309159148, 721.7365661533555, 15428.768568471482, 15722.68554628901, 15769.842301577068, 15925.362985480568, 16211.432599859067, 14620.97653164279, 14779.26103694811, 15036.398544058224, 15044.0, 15247.542573722805, 11655.19547607525, 11666.442139296827, 11852.40737963107, 12354.567590134302, 12434.75130497385, 3811.790351530665, 3837.1558257183374, 3846.788426636562, 4046.0, 4070.124923141509, 108444.4577777114, 112540.0, 113244.0, 114856.0, 115088.99999999916, 10345.379277243239, 11322.32066076038, 11490.368029758443, 11864.584739534075, 11901.702457438634, 21877.562448750938, 23811.047558097827, 24079.157229497236, 24167.033318667058, 24348.269551913472, 8009.599520023976, 8018.879716804253, 8025.438219324591, 8100.149484304181, 8215.753527394188, 4189.664826813848, 4194.916101677949, 4286.39990401344, 4361.367601697736, 4462.888427789331, 3702.333579955634, 3710.703143748494, 3817.6182381762155, 3819.197968426606, 3837.213371258885, 577.4283459375189, 677.6075165534775, 687.3847906123991, 697.5361384679131, 700.9544379615309, 680.0313093594018, 698.7240040184099, 705.5131958948309, 718.989215161773, 774.5314084978506, 10165.339252948535, 10453.027849417325, 10633.893661063445, 10767.6231331903, 10836.94581527103, 636.920384951881, 652.3150691773714, 702.304718328861, 713.1157364867527, 746.9691825281077, 5023.773930173151, 5159.613029022838, 5165.0, 5171.534561889448, 5183.300254465675, 113553.43223283831, 116635.0, 117965.0, 118260.0, 120610.39694801469, 89841.55079224693, 93693.0630693698, 95332.52333738287, 97742.51128744453, 98021.15830733524, 86896.0, 88434.55782721174, 88814.0, 89587.0, 91094.54452727959, 9809.3296558341, 9863.309568330147, 9876.40741555509, 9965.0, 9983.101520863158, 42100.57899420967, 50513.0, 51680.74159629178, 52034.95930081453, 52956.73521632367, 68562.65718671575, 69767.2558186029, 71215.57568848491, 71369.0, 71510.64244678743, 10358.637447689294, 11817.704557386134, 11857.525698971944, 11908.880911191123, 11912.285262884254, 12521.248725076524, 12657.240565566095, 12794.808077879026, 13012.0, 13787.965902557147, 11853.466594003117, 12246.816297755362, 12418.316992565135, 12634.620961371174, 12832.101752877208, 11812.114091443003, 12102.152849300464, 12263.69340766488, 12382.690432739253, 12758.872411275768, 11486.310821350746, 11981.28112313264, 11982.820257696316, 12003.879961200277, 12143.0, 9937.701868943943, 10582.868626972824, 10599.470026498799, 10674.946625266824, 10808.729781755519, 8160.918390816016, 9398.34211605181, 10119.494025298558, 10143.0, 10259.589616415558], "value": 7627.211746856731, "unit": "score"}], "name": "dromaeo_css", "value": 7389.593077249688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 114.0, 111.0, 112.0, 114.0, 113.0, 112.0, 114.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 140.0, 179.0, 109.0, 109.0, 112.0, 131.0, 159.0, 114.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 182.0, 182.0, 183.0, 183.0, 183.0, 183.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 58.0, 90.0, 60.0, 58.0, 57.0, 57.0, 72.0, 58.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 107.0, 102.0, 98.0, 80.0, 81.0, 67.0, 68.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 84.0, 86.0, 87.0, 87.0, 85.0, 87.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 110.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 88.0, 87.0, 87.0, 89.0, 85.0, 84.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 56.0, 57.0, 58.0, 58.0, 58.0, 56.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 65.0, 73.0, 70.0, 69.0, 68.0, 67.0, 68.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 83.0, 86.0, 82.0, 90.0, 100.0, 100.0, 88.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 145.0, 150.0, 132.0, 133.0, 154.0, 154.0, 162.0, 125.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 163.0, 162.0, 162.0, 161.0, 160.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 67.0, 65.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1430.4999999999998, "alertThreshold": 2.0}]} 04:45:53 INFO - Return code: 0 04:45:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:53 INFO - # TBPL SUCCESS # 04:45:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:53 INFO - 2017-03-21 04:45:53.728 screenresolution[2221:27723] starting screenresolution argv=screenresolution get 04:45:53 INFO - 2017-03-21 04:45:53.730 screenresolution[2221:27723] Display 0: 1600x1200x32@60 04:45:53 INFO - 2017-03-21 04:45:53.736 screenresolution[2222:27726] starting screenresolution argv=screenresolution list 04:45:53 INFO - Available Modes on Display 0 04:45:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:53 INFO - Intel Iris: 04:45:53 INFO - Chipset Model: Intel Iris 04:45:53 INFO - Type: GPU 04:45:53 INFO - Bus: Built-In 04:45:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:53 INFO - Vendor: Intel (0x8086) 04:45:53 INFO - Device ID: 0x0a2e 04:45:53 INFO - Revision ID: 0x0009 04:45:53 INFO - Displays: 04:45:53 INFO - Display: 04:45:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:53 INFO - Display Serial Number: 1600x1200 60 04:45:53 INFO - Main Display: Yes 04:45:53 INFO - Mirror: Off 04:45:53 INFO - Online: Yes 04:45:53 INFO - Rotation: Supported 04:45:53 INFO - Return code: 0 04:45:53 INFO - Running post-action listener: _resource_record_post_action 04:45:53 INFO - [mozharness: 2017-03-21 11:45:53.971045Z] Finished run-tests step (success) 04:45:53 INFO - Running post-run listener: _resource_record_post_run 04:45:54 INFO - Total resource usage - Wall time: 1190s; CPU: 53.0%; Read bytes: 712704; Write bytes: 421500928; Read time: 9; Write time: 1617 04:45:54 INFO - TinderboxPrint: CPU usage
53.5% 04:45:54 INFO - TinderboxPrint: I/O read bytes / time
712,704 / 9 04:45:54 INFO - TinderboxPrint: I/O write bytes / time
421,500,928 / 1,617 04:45:54 INFO - TinderboxPrint: CPU idle
2,215.2 (46.5%) 04:45:54 INFO - TinderboxPrint: CPU system
954.2 (20.0%) 04:45:54 INFO - TinderboxPrint: CPU user
1,592.3 (33.4%) 04:45:54 INFO - TinderboxPrint: Swap in / out
122,355,712 / 0 04:45:54 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 107653632; Write bytes: 102378496; Read time: 9827; Write time: 246 04:45:54 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 712704; Write bytes: 297593856; Read time: 9; Write time: 1312 04:45:54 INFO - Running post-run listener: _upload_blobber_files 04:45:54 INFO - Blob upload gear active. 04:45:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:54 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 04:45:54 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:54 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:56 INFO - (blobuploader) - INFO - Done attempting. 04:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:57 INFO - (blobuploader) - INFO - Done attempting. 04:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:58 INFO - (blobuploader) - INFO - Done attempting. 04:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:00 INFO - (blobuploader) - INFO - Done attempting. 04:46:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:00 INFO - Return code: 0 04:46:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8ac76f730dd91459a35000b721991a152d345e6d366fc8d326fb6493023e7a18af4196603df1a41ddf11e360afdbcaa52344ca8fb13c52b18eca24dab765460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e521a67fb5ba7d0873b890e83330caf5759dd92c10cb5c4400d91d26fd12a5000f29466119f457b6ef8064dadb5d39323a73683406b3609ddf2001f9c1e4060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436fb23b8ebfd07e44f1b54133a8c351493c715416bc878da7f4153032f3b9e0f19b34ad54bc1faee224e67580349a18de98901f8830311a95ec2513743e8cbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/206203415caefe0d283a5675cd14fa4cfaf6762080996219ca3108dec0e9d9fd247e7eaff7c83a97d0fde4bb70d873d85039447b18fb142bad693cd408126f85"} 04:46:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:00 INFO - Contents: 04:46:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8ac76f730dd91459a35000b721991a152d345e6d366fc8d326fb6493023e7a18af4196603df1a41ddf11e360afdbcaa52344ca8fb13c52b18eca24dab765460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e521a67fb5ba7d0873b890e83330caf5759dd92c10cb5c4400d91d26fd12a5000f29466119f457b6ef8064dadb5d39323a73683406b3609ddf2001f9c1e4060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436fb23b8ebfd07e44f1b54133a8c351493c715416bc878da7f4153032f3b9e0f19b34ad54bc1faee224e67580349a18de98901f8830311a95ec2513743e8cbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/206203415caefe0d283a5675cd14fa4cfaf6762080996219ca3108dec0e9d9fd247e7eaff7c83a97d0fde4bb70d873d85039447b18fb142bad693cd408126f85"} 04:46:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:00 INFO - Copying logs to upload dir... 04:46:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.510847 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-21 04:46:00.612656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:46:00.615781) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8ac76f730dd91459a35000b721991a152d345e6d366fc8d326fb6493023e7a18af4196603df1a41ddf11e360afdbcaa52344ca8fb13c52b18eca24dab765460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e521a67fb5ba7d0873b890e83330caf5759dd92c10cb5c4400d91d26fd12a5000f29466119f457b6ef8064dadb5d39323a73683406b3609ddf2001f9c1e4060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436fb23b8ebfd07e44f1b54133a8c351493c715416bc878da7f4153032f3b9e0f19b34ad54bc1faee224e67580349a18de98901f8830311a95ec2513743e8cbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/206203415caefe0d283a5675cd14fa4cfaf6762080996219ca3108dec0e9d9fd247e7eaff7c83a97d0fde4bb70d873d85039447b18fb142bad693cd408126f85"} build_url:https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8ac76f730dd91459a35000b721991a152d345e6d366fc8d326fb6493023e7a18af4196603df1a41ddf11e360afdbcaa52344ca8fb13c52b18eca24dab765460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e521a67fb5ba7d0873b890e83330caf5759dd92c10cb5c4400d91d26fd12a5000f29466119f457b6ef8064dadb5d39323a73683406b3609ddf2001f9c1e4060", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/436fb23b8ebfd07e44f1b54133a8c351493c715416bc878da7f4153032f3b9e0f19b34ad54bc1faee224e67580349a18de98901f8830311a95ec2513743e8cbf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/206203415caefe0d283a5675cd14fa4cfaf6762080996219ca3108dec0e9d9fd247e7eaff7c83a97d0fde4bb70d873d85039447b18fb142bad693cd408126f85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:46:00.651160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:46:00.651524) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TrRDM9R9OH/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.qWDBg7BtW0/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:46:00.700437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:46:00.700779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:46:00.701102) ========= ========= Total master_lag: 0.36 =========