builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1491473346.43 results: success (0) buildid: 20170406021722 builduid: a004747d34d1468895b1e9d3cef38807 revision: acc4c147ae006e22c51820caf6386054d6e05a31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.427129) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.427566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.427851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.457066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.457486) ========= 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.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-04-06 03:09:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-04-06 03:09:06 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.605754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.606082) ========= 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.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.030410 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:06.661271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-06 03:09:06.661630) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev acc4c147ae006e22c51820caf6386054d6e05a31 --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 acc4c147ae006e22c51820caf6386054d6e05a31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-04-06 03:09:06,781 truncating revision to first 12 chars 2017-04-06 03:09:06,782 Setting DEBUG logging. 2017-04-06 03:09:06,782 attempt 1/10 2017-04-06 03:09:06,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/acc4c147ae00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 03:09:08,778 unpacking tar archive at: mozilla-beta-acc4c147ae00/testing/mozharness/ program finished with exit code 0 elapsedTime=2.264325 ========= master_lag: 2.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-06 03:09:11.010238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:11.010571) ========= script_repo_revision: acc4c147ae006e22c51820caf6386054d6e05a31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:11.011005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:11.014014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 03:09:11.036723) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 03:09:11.037138) ========= /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.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:11 INFO - MultiFileLogger online at 20170406 03:09:11 in /builds/slave/test 03:09:11 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 03:09:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:11 INFO - {'append_to_log': False, 03:09:11 INFO - 'base_work_dir': '/builds/slave/test', 03:09:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:09:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:11 INFO - 'branch': 'Mozilla-Beta', 03:09:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:11 INFO - 'config_files': ('talos/mac_config.py',), 03:09:11 INFO - 'default_actions': ('clobber', 03:09:11 INFO - 'read-buildbot-config', 03:09:11 INFO - 'download-and-extract', 03:09:11 INFO - 'populate-webroot', 03:09:11 INFO - 'create-virtualenv', 03:09:11 INFO - 'install', 03:09:11 INFO - 'run-tests'), 03:09:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:11 INFO - 'download_minidump_stackwalk': True, 03:09:11 INFO - 'download_symbols': 'ondemand', 03:09:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:11 INFO - 'installer_path': 'installer.exe', 03:09:11 INFO - 'log_level': 'info', 03:09:11 INFO - 'log_name': 'talos', 03:09:11 INFO - 'log_to_console': True, 03:09:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:09:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:09:11 INFO - 'opt_config_files': (), 03:09:11 INFO - 'pip_index': False, 03:09:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:11 INFO - 'cmd': ('bash', 03:09:11 INFO - '-c', 03:09:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:11 INFO - 'enabled': True, 03:09:11 INFO - 'halt_on_failure': False, 03:09:11 INFO - 'name': 'check_screen_resolution'},), 03:09:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:09:11 INFO - 'cmd': ('bash', 03:09:11 INFO - '-c', 03:09:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:09:11 INFO - 'enabled': True, 03:09:11 INFO - 'halt_on_failure': False, 03:09:11 INFO - 'name': 'check_screen_resolution'},), 03:09:11 INFO - 'run_cmd_checks_enabled': True, 03:09:11 INFO - 'sps_profile': False, 03:09:11 INFO - 'sps_profile_interval': 0, 03:09:11 INFO - 'suite': 'dromaeojs', 03:09:11 INFO - 'system_bits': '32', 03:09:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:11 INFO - 'title': 't-yosemite-r7-0253', 03:09:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:11 INFO - 'use_talos_json': True, 03:09:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:11 INFO - 'work_dir': 'build'} 03:09:11 INFO - [mozharness: 2017-04-06 10:09:11.264526Z] Running clobber step. 03:09:11 INFO - Running pre-action listener: _resource_record_pre_action 03:09:11 INFO - Running main action method: clobber 03:09:11 INFO - rmtree: /builds/slave/test/build 03:09:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:13 INFO - Running post-action listener: _resource_record_post_action 03:09:13 INFO - [mozharness: 2017-04-06 10:09:13.663925Z] Finished clobber step (success) 03:09:13 INFO - [mozharness: 2017-04-06 10:09:13.664063Z] Running read-buildbot-config step. 03:09:13 INFO - Running pre-action listener: _resource_record_pre_action 03:09:13 INFO - Running main action method: read_buildbot_config 03:09:13 INFO - Using buildbot properties: 03:09:13 INFO - { 03:09:13 INFO - "project": "", 03:09:13 INFO - "product": "firefox", 03:09:13 INFO - "script_repo_revision": "production", 03:09:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 03:09:13 INFO - "repository": "", 03:09:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 03:09:13 INFO - "buildid": "20170406021722", 03:09:13 INFO - "pgo_build": "False", 03:09:13 INFO - "basedir": "/builds/slave/test", 03:09:13 INFO - "buildnumber": 14, 03:09:13 INFO - "slavename": "t-yosemite-r7-0253", 03:09:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:09:13 INFO - "platform": "yosemite_r7", 03:09:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:09:13 INFO - "branch": "mozilla-beta", 03:09:13 INFO - "repo_path": "releases/mozilla-beta", 03:09:13 INFO - "revision": "acc4c147ae006e22c51820caf6386054d6e05a31", 03:09:13 INFO - "stage_platform": "macosx64", 03:09:13 INFO - "builduid": "a004747d34d1468895b1e9d3cef38807", 03:09:13 INFO - "slavebuilddir": "test" 03:09:13 INFO - } 03:09:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 03:09:13 INFO - Running post-action listener: _resource_record_post_action 03:09:13 INFO - [mozharness: 2017-04-06 10:09:13.667140Z] Finished read-buildbot-config step (success) 03:09:13 INFO - [mozharness: 2017-04-06 10:09:13.667277Z] Running download-and-extract step. 03:09:13 INFO - Running pre-action listener: _resource_record_pre_action 03:09:13 INFO - Running main action method: download_and_extract 03:09:13 INFO - mkdir: /builds/slave/test/build/tests 03:09:13 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')]} 03:09:13 INFO - trying https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 03:09:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/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 03:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/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 03:09:14 INFO - Downloaded 1165 bytes. 03:09:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 03:09:14 INFO - Using the following test package requirements: 03:09:14 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:09:14 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 03:09:14 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 03:09:14 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:09:14 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 03:09:14 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:09:14 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 03:09:14 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 03:09:14 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 03:09:14 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:09:14 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 03:09:14 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 03:09:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:09:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:09:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:09:15 INFO - Expected file size: 16116375 03:09:15 INFO - Obtained file size: 16116375 03:09:21 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 03:09:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:09:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:09:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:09:22 INFO - Expected file size: 16116375 03:09:22 INFO - Obtained file size: 16116375 03:09:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 03:09:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 03:09:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 03:09:30 INFO - Expected file size: 14403663 03:09:30 INFO - Obtained file size: 14403663 03:09:30 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')]} 03:09:30 INFO - trying https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:09:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 03:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/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 03:09:33 INFO - Downloaded 58738193 bytes. 03:09:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:09:33 INFO - mkdir: /builds/slave/test/properties 03:09:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:09:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:09:33 INFO - Contents: 03:09:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:09:34 INFO - Running post-action listener: _resource_record_post_action 03:09:34 INFO - Running post-action listener: set_extra_try_arguments 03:09:34 INFO - [mozharness: 2017-04-06 10:09:34.083124Z] Finished download-and-extract step (success) 03:09:34 INFO - [mozharness: 2017-04-06 10:09:34.083276Z] Running populate-webroot step. 03:09:34 INFO - Running pre-action listener: _resource_record_pre_action 03:09:34 INFO - Running main action method: populate_webroot 03:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:09:34 INFO - '--tppagecycles', 03:09:34 INFO - '7'], 03:09:34 INFO - 'tests': ['tsvgm']}}, 03:09:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:09:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:09:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:09:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:09:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:09:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['damp', 'tps']}, 03:09:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'tests': ['damp', 'tps']}, 03:09:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['dromaeo_dom']}, 03:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:09:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['basic_compositor_video']}, 03:09:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:09:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['a11yr', 03:09:34 INFO - 'ts_paint', 03:09:34 INFO - 'tpaint', 03:09:34 INFO - 'sessionrestore', 03:09:34 INFO - 'sessionrestore_no_auto_restore', 03:09:34 INFO - 'tabpaint']}, 03:09:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['tsvgx', 03:09:34 INFO - 'tsvgr_opacity', 03:09:34 INFO - 'tart', 03:09:34 INFO - 'tscrollx', 03:09:34 INFO - 'cart', 03:09:34 INFO - 'tsvg_static']}, 03:09:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:09:34 INFO - 'tsvgr_opacity', 03:09:34 INFO - 'tart', 03:09:34 INFO - 'tscrollx', 03:09:34 INFO - 'cart', 03:09:34 INFO - 'tsvg_static']}, 03:09:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'talos_options': ['--disable-e10s'], 03:09:34 INFO - 'tests': ['tp5o']}, 03:09:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:09:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'talos_options': ['--disable-e10s', 03:09:34 INFO - '--xperf_path', 03:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:34 INFO - 'tests': ['tp5n']}, 03:09:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:09:34 INFO - 'talos_options': ['--xperf_path', 03:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:09:34 INFO - 'tests': ['tp5n']}}, 03:09:34 INFO - 'talos.zip': {'path': '', 03:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:09:34 INFO - Running post-action listener: _resource_record_post_action 03:09:34 INFO - [mozharness: 2017-04-06 10:09:34.101919Z] Finished populate-webroot step (success) 03:09:34 INFO - [mozharness: 2017-04-06 10:09:34.102034Z] Running create-virtualenv step. 03:09:34 INFO - Running pre-action listener: _resource_record_pre_action 03:09:34 INFO - Running main action method: create_virtualenv 03:09:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:09:34 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 03:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:09:34 INFO - Using real prefix '/tools/python27' 03:09:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:09:37 INFO - Installing pip.................done. 03:09:37 INFO - Return code: 0 03:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:09:38 INFO - Reading from file tmpfile_stdout 03:09:38 INFO - Output received: 03:09:38 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) 03:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:09:38 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')]} 03:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 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')]} 03:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:38 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 03:09:38 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 03:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:38 INFO - 'HOME': '/Users/cltbld', 03:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:38 INFO - 'LOGNAME': 'cltbld', 03:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:38 INFO - 'MOZ_NO_REMOTE': '1', 03:09:38 INFO - 'NO_EM_RESTART': '1', 03:09:38 INFO - 'PAGER': '/bin/cat', 03:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:38 INFO - 'PWD': '/builds/slave/test', 03:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:38 INFO - 'SHELL': '/bin/bash', 03:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:38 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:38 INFO - 'USER': 'cltbld', 03:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:38 INFO - 'XPC_FLAGS': '0x0', 03:09:38 INFO - 'XPC_SERVICE_NAME': '0', 03:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:38 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 03:09:38 INFO - Cleaning up... 03:09:38 INFO - Return code: 0 03:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:09:38 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')]} 03:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 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')]} 03:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:38 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:38 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 03:09:38 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 03:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:38 INFO - 'HOME': '/Users/cltbld', 03:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:38 INFO - 'LOGNAME': 'cltbld', 03:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:38 INFO - 'MOZ_NO_REMOTE': '1', 03:09:38 INFO - 'NO_EM_RESTART': '1', 03:09:38 INFO - 'PAGER': '/bin/cat', 03:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:38 INFO - 'PWD': '/builds/slave/test', 03:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:38 INFO - 'SHELL': '/bin/bash', 03:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:38 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:38 INFO - 'USER': 'cltbld', 03:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:38 INFO - 'XPC_FLAGS': '0x0', 03:09:38 INFO - 'XPC_SERVICE_NAME': '0', 03:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:38 INFO - Downloading/unpacking psutil>=3.1.1 03:09:38 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 03:09:38 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 03:09:38 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 03:09:38 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 03:09:38 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 03:09:38 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 03:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:42 INFO - Installing collected packages: psutil 03:09:42 INFO - Running setup.py install for psutil 03:09:42 INFO - building 'psutil._psutil_osx' extension 03:09:42 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 03:09:42 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 03:09:42 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 03:09:42 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 03:09:42 INFO - building 'psutil._psutil_posix' extension 03:09:42 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 03:09:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:09:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:09:43 INFO - ^ 03:09:43 INFO - 1 warning generated. 03:09:43 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 03:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:09:43 INFO - Successfully installed psutil 03:09:43 INFO - Cleaning up... 03:09:43 INFO - Return code: 0 03:09:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:09: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')]} 03:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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')]} 03:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:09: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 mozsystemmonitor==0.3 03:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:43 INFO - 'HOME': '/Users/cltbld', 03:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:43 INFO - 'LOGNAME': 'cltbld', 03:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:43 INFO - 'MOZ_NO_REMOTE': '1', 03:09:43 INFO - 'NO_EM_RESTART': '1', 03:09:43 INFO - 'PAGER': '/bin/cat', 03:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:43 INFO - 'PWD': '/builds/slave/test', 03:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:43 INFO - 'SHELL': '/bin/bash', 03:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:43 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:43 INFO - 'USER': 'cltbld', 03:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:43 INFO - 'XPC_FLAGS': '0x0', 03:09:43 INFO - 'XPC_SERVICE_NAME': '0', 03:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:46 INFO - Installing collected packages: mozsystemmonitor 03:09:46 INFO - Running setup.py install for mozsystemmonitor 03:09:46 INFO - Successfully installed mozsystemmonitor 03:09:46 INFO - Cleaning up... 03:09:46 INFO - Return code: 0 03:09:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:46 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')]} 03:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:46 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')]} 03:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:46 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:46 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 03:09:46 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 03:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:46 INFO - 'HOME': '/Users/cltbld', 03:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:46 INFO - 'LOGNAME': 'cltbld', 03:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:46 INFO - 'MOZ_NO_REMOTE': '1', 03:09:46 INFO - 'NO_EM_RESTART': '1', 03:09:46 INFO - 'PAGER': '/bin/cat', 03:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:46 INFO - 'PWD': '/builds/slave/test', 03:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:46 INFO - 'SHELL': '/bin/bash', 03:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:46 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:46 INFO - 'USER': 'cltbld', 03:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:46 INFO - 'XPC_FLAGS': '0x0', 03:09:46 INFO - 'XPC_SERVICE_NAME': '0', 03:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 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 03:09:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:49 INFO - warning: no files found matching '*.txt' 03:09:49 INFO - no previously-included directories found matching 'build' 03:09:49 INFO - no previously-included directories found matching 'dist' 03:09:49 INFO - no previously-included directories found matching '.git*' 03:09:49 INFO - Installing collected packages: jsonschema, functools32 03:09:49 INFO - Running setup.py install for functools32 03:09:50 INFO - warning: no files found matching '*.txt' 03:09:50 INFO - no previously-included directories found matching 'build' 03:09:50 INFO - no previously-included directories found matching 'dist' 03:09:50 INFO - no previously-included directories found matching '.git*' 03:09:50 INFO - Successfully installed jsonschema functools32 03:09:50 INFO - Cleaning up... 03:09:50 INFO - Return code: 0 03:09:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09:50 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')]} 03:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:50 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')]} 03:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:50 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:50 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 03:09:50 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 03:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:50 INFO - 'HOME': '/Users/cltbld', 03:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:50 INFO - 'LOGNAME': 'cltbld', 03:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:50 INFO - 'MOZ_NO_REMOTE': '1', 03:09:50 INFO - 'NO_EM_RESTART': '1', 03:09:50 INFO - 'PAGER': '/bin/cat', 03:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:50 INFO - 'PWD': '/builds/slave/test', 03:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:50 INFO - 'SHELL': '/bin/bash', 03:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:50 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:50 INFO - 'USER': 'cltbld', 03:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:50 INFO - 'XPC_FLAGS': '0x0', 03:09:50 INFO - 'XPC_SERVICE_NAME': '0', 03:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:50 INFO - Cleaning up... 03:09:50 INFO - Return code: 0 03:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:50 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')]} 03:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:50 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')]} 03:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:50 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:50 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 03:09:50 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 03:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:50 INFO - 'HOME': '/Users/cltbld', 03:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:50 INFO - 'LOGNAME': 'cltbld', 03:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:50 INFO - 'MOZ_NO_REMOTE': '1', 03:09:50 INFO - 'NO_EM_RESTART': '1', 03:09:50 INFO - 'PAGER': '/bin/cat', 03:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:50 INFO - 'PWD': '/builds/slave/test', 03:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:50 INFO - 'SHELL': '/bin/bash', 03:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:50 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:50 INFO - 'USER': 'cltbld', 03:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:50 INFO - 'XPC_FLAGS': '0x0', 03:09:50 INFO - 'XPC_SERVICE_NAME': '0', 03:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:09:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:53 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 03:09:53 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 03:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:54 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 03:09:54 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 03:09:54 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 03:09:54 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 03:09:54 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 03:09:54 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 03:09:54 INFO - Downloading docopt-0.6.1.tar.gz 03:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:54 INFO - Running setup.py install for blobuploader 03:09:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:54 INFO - Running setup.py install for requests 03:09:55 INFO - Running setup.py install for docopt 03:09:55 INFO - Successfully installed blobuploader requests docopt 03:09:55 INFO - Cleaning up... 03:09:55 INFO - Return code: 0 03:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:55 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')]} 03:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:55 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')]} 03:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:55 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:09:55 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 03:09:55 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 03:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:55 INFO - 'HOME': '/Users/cltbld', 03:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:55 INFO - 'LOGNAME': 'cltbld', 03:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:55 INFO - 'MOZ_NO_REMOTE': '1', 03:09:55 INFO - 'NO_EM_RESTART': '1', 03:09:55 INFO - 'PAGER': '/bin/cat', 03:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:55 INFO - 'PWD': '/builds/slave/test', 03:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:55 INFO - 'SHELL': '/bin/bash', 03:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:09:55 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:55 INFO - 'USER': 'cltbld', 03:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:55 INFO - 'XPC_FLAGS': '0x0', 03:09:55 INFO - 'XPC_SERVICE_NAME': '0', 03:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:55 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-SWWvuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-kPg_j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Ql64G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-XFxxd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Ix82Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-46JDvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-mvagq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fUW6Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Nqddrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:56 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-40kq8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-XF7YlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-sXOtBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-RDKza3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-UmhOVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-rjgSIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-qFOgJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:57 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-dLYRdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:57 INFO - Running setup.py install for manifestparser 03:09:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:57 INFO - Running setup.py install for mozcrash 03:09:58 INFO - Running setup.py install for mozdebug 03:09:58 INFO - Running setup.py install for mozdevice 03:09:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Running setup.py install for mozfile 03:09:58 INFO - Running setup.py install for mozhttpd 03:09:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Running setup.py install for mozinfo 03:09:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Running setup.py install for mozInstall 03:09:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:58 INFO - Running setup.py install for mozleak 03:09:59 INFO - Running setup.py install for mozlog 03:09:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Running setup.py install for moznetwork 03:09:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Running setup.py install for mozprocess 03:09:59 INFO - Running setup.py install for mozprofile 03:09:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Running setup.py install for mozrunner 03:09:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:59 INFO - Running setup.py install for mozscreenshot 03:10:00 INFO - Running setup.py install for moztest 03:10:00 INFO - Running setup.py install for mozversion 03:10:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:00 INFO - Cleaning up... 03:10:00 INFO - Return code: 0 03:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:00 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')]} 03:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:00 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')]} 03:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:01 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:10:01 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 03:10:01 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 03:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:01 INFO - 'HOME': '/Users/cltbld', 03:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:01 INFO - 'LOGNAME': 'cltbld', 03:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:01 INFO - 'MOZ_NO_REMOTE': '1', 03:10:01 INFO - 'NO_EM_RESTART': '1', 03:10:01 INFO - 'PAGER': '/bin/cat', 03:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:01 INFO - 'PWD': '/builds/slave/test', 03:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:01 INFO - 'SHELL': '/bin/bash', 03:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:10:01 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:01 INFO - 'USER': 'cltbld', 03:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:01 INFO - 'XPC_FLAGS': '0x0', 03:10:01 INFO - 'XPC_SERVICE_NAME': '0', 03:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-2QaIC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ynS6C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-kHrPep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-w7NPkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-W_bx0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Df6QBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:01 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)) 03:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:01 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-1epX8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lZcR0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-EIvJSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-xi4yr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-kxnyu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ghbYeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jkLeQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-CikBjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-g1Efe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:02 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)) 03:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:02 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-LdZH8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:03 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)) 03:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-FdFjwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 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)) 03:10:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:06 INFO - Downloading blessings-1.6.tar.gz 03:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:06 INFO - Installing collected packages: blessings 03:10:06 INFO - Running setup.py install for blessings 03:10:06 INFO - Successfully installed blessings 03:10:06 INFO - Cleaning up... 03:10:06 INFO - Return code: 0 03:10:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:06 INFO - Reading from file tmpfile_stdout 03:10:06 INFO - Current package versions: 03:10:06 INFO - blessings == 1.6 03:10:06 INFO - blobuploader == 1.2.4 03:10:06 INFO - docopt == 0.6.1 03:10:06 INFO - functools32 == 3.2.3-2 03:10:06 INFO - jsonschema == 2.5.1 03:10:06 INFO - manifestparser == 1.1 03:10:06 INFO - mozInstall == 1.12 03:10:06 INFO - mozcrash == 1.0 03:10:06 INFO - mozdebug == 0.1 03:10:06 INFO - mozdevice == 0.49 03:10:06 INFO - mozfile == 1.2 03:10:06 INFO - mozhttpd == 0.7 03:10:06 INFO - mozinfo == 0.9 03:10:06 INFO - mozleak == 0.1 03:10:06 INFO - mozlog == 3.4 03:10:06 INFO - moznetwork == 0.27 03:10:06 INFO - mozprocess == 0.24 03:10:06 INFO - mozprofile == 0.28 03:10:06 INFO - mozrunner == 6.13 03:10:06 INFO - mozscreenshot == 0.1 03:10:06 INFO - mozsystemmonitor == 0.3 03:10:06 INFO - moztest == 0.8 03:10:06 INFO - mozversion == 1.4 03:10:06 INFO - psutil == 3.1.1 03:10:06 INFO - requests == 1.2.3 03:10:06 INFO - wsgiref == 0.1.2 03:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:06 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')]} 03:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:06 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')]} 03:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:06 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:10:06 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 03:10:06 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 03:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:06 INFO - 'HOME': '/Users/cltbld', 03:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:06 INFO - 'LOGNAME': 'cltbld', 03:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:06 INFO - 'MOZ_NO_REMOTE': '1', 03:10:06 INFO - 'NO_EM_RESTART': '1', 03:10:06 INFO - 'PAGER': '/bin/cat', 03:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:06 INFO - 'PWD': '/builds/slave/test', 03:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:06 INFO - 'SHELL': '/bin/bash', 03:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:10:06 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:06 INFO - 'USER': 'cltbld', 03:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:06 INFO - 'XPC_FLAGS': '0x0', 03:10:06 INFO - 'XPC_SERVICE_NAME': '0', 03:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 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)) 03:10:06 INFO - Cleaning up... 03:10:06 INFO - Return code: 0 03:10:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:06 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')]} 03:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:06 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')]} 03:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:06 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 0x10dc1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb531569740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, '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.Qlb5OnBBvM/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.40h7x35qhF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 03:10:06 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 03:10:06 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 03:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:06 INFO - 'HOME': '/Users/cltbld', 03:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:06 INFO - 'LOGNAME': 'cltbld', 03:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:06 INFO - 'MOZ_NO_REMOTE': '1', 03:10:06 INFO - 'NO_EM_RESTART': '1', 03:10:06 INFO - 'PAGER': '/bin/cat', 03:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:06 INFO - 'PWD': '/builds/slave/test', 03:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:06 INFO - 'SHELL': '/bin/bash', 03:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:10:06 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:06 INFO - 'USER': 'cltbld', 03:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:06 INFO - 'XPC_FLAGS': '0x0', 03:10:06 INFO - 'XPC_SERVICE_NAME': '0', 03:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:07 INFO - Cleaning up... 03:10:07 INFO - Return code: 0 03:10:07 INFO - Running post-action listener: _resource_record_post_action 03:10:07 INFO - Running post-action listener: _start_resource_monitoring 03:10:07 INFO - Starting resource monitoring. 03:10:07 INFO - [mozharness: 2017-04-06 10:10:07.290181Z] Finished create-virtualenv step (success) 03:10:07 INFO - [mozharness: 2017-04-06 10:10:07.291198Z] Running install step. 03:10:07 INFO - Running pre-action listener: _resource_record_pre_action 03:10:07 INFO - Running main action method: install 03:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:07 INFO - Reading from file tmpfile_stdout 03:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:07 INFO - Reading from file tmpfile_stdout 03:10:07 INFO - Output received: 03:10:07 INFO - Usage: mozinstall [options] installer 03:10:07 INFO - Options: 03:10:07 INFO - -h, --help show this help message and exit 03:10:07 INFO - -d DEST, --destination=DEST 03:10:07 INFO - Directory to install application into. [default: 03:10:07 INFO - "/builds/slave/test"] 03:10:07 INFO - --app=APP Application being installed. [default: firefox] 03:10:07 INFO - mkdir: /builds/slave/test/build/application 03:10:07 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'] 03:10:07 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 03:10:22 INFO - Reading from file tmpfile_stdout 03:10:22 INFO - Output received: 03:10:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:10:22 INFO - Running post-action listener: _resource_record_post_action 03:10:22 INFO - [mozharness: 2017-04-06 10:10:22.213138Z] Finished install step (success) 03:10:22 INFO - [mozharness: 2017-04-06 10:10:22.213293Z] Running run-tests step. 03:10:22 INFO - Running pre-action listener: _resource_record_pre_action 03:10:22 INFO - Running main action method: run_tests 03:10:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:10:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:10:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:10:22 INFO - 2017-04-06 03:10:22.227 screenresolution[1626:7326] starting screenresolution argv=screenresolution get 03:10:22 INFO - 2017-04-06 03:10:22.230 screenresolution[1626:7326] Display 0: 1600x1200x32@60 03:10:22 INFO - 2017-04-06 03:10:22.236 screenresolution[1627:7328] starting screenresolution argv=screenresolution list 03:10:22 INFO - Available Modes on Display 0 03:10:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:10:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:10:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:10:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:10:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:10:22 INFO - Intel Iris: 03:10:22 INFO - Chipset Model: Intel Iris 03:10:22 INFO - Type: GPU 03:10:22 INFO - Bus: Built-In 03:10:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:10:22 INFO - Vendor: Intel (0x8086) 03:10:22 INFO - Device ID: 0x0a2e 03:10:22 INFO - Revision ID: 0x0009 03:10:22 INFO - Displays: 03:10:22 INFO - Display: 03:10:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:10:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:10:22 INFO - Display Serial Number: 1600x1200 60 03:10:22 INFO - Main Display: Yes 03:10:22 INFO - Mirror: Off 03:10:22 INFO - Online: Yes 03:10:22 INFO - Rotation: Supported 03:10:22 INFO - Return code: 0 03:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:22 INFO - Python 2.7.3 03:10:22 INFO - Return code: 0 03:10:22 INFO - grabbing minidump binary from tooltool 03:10:22 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')]} 03:10:22 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 0x10d9fbd30>, '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 0x10d922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:22 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 03:10:22 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 03:10:22 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 03:10:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:22 INFO - Return code: 0 03:10:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:10:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:10:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:22 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/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 03:10:22 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/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --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 03:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qlb5OnBBvM/Render', 03:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:10:22 INFO - 'HOME': '/Users/cltbld', 03:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:10:22 INFO - 'LOGNAME': 'cltbld', 03:10:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:22 INFO - 'MOZ_NO_REMOTE': '1', 03:10:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:22 INFO - 'NO_EM_RESTART': '1', 03:10:22 INFO - 'PAGER': '/bin/cat', 03:10:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:22 INFO - 'PWD': '/builds/slave/test', 03:10:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:10:22 INFO - 'SHELL': '/bin/bash', 03:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.40h7x35qhF/Listeners', 03:10:22 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 03:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:10:22 INFO - 'USER': 'cltbld', 03:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:22 INFO - 'XPC_FLAGS': '0x0', 03:10:22 INFO - 'XPC_SERVICE_NAME': '0', 03:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:10:22 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/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 03:10:22 INFO - mozversion application_buildid: 20170406021722 03:10:22 INFO - mozversion application_changeset: acc4c147ae006e22c51820caf6386054d6e05a31 03:10:22 INFO - mozversion application_display_name: Firefox 03:10:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:22 INFO - mozversion application_name: Firefox 03:10:22 INFO - mozversion application_remotingname: firefox 03:10:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:10:22 INFO - mozversion application_vendor: Mozilla 03:10:22 INFO - mozversion application_version: 53.0 03:10:22 INFO - mozversion platform_buildid: 20170406021722 03:10:22 INFO - mozversion platform_changeset: acc4c147ae006e22c51820caf6386054d6e05a31 03:10:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:10:22 INFO - mozversion platform_version: 53.0 03:10:22 INFO - using testdate: 1491473422 03:10:22 INFO - actual date: 1491473422 03:10:22 INFO - starting webserver on 'localhost:49249' 03:10:22 INFO - SUITE-START | Running 2 tests 03:10:22 INFO - TEST-START | dromaeo_css 03:10:22 INFO - operating with platform_type : mac_ 03:10:22 INFO - Initialising browser for dromaeo_css test... 03:10:22 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpaeG4Cy/profile http://localhost:49249/getInfo.html) 03:10:25 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 03:10:25 INFO - PROCESS | 1637 | colorDepth:24 03:10:25 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 03:10:25 INFO - PROCESS | 1637 | __metrics 03:10:25 INFO - PROCESS | 1637 | 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" 03:10:25 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:26 INFO - TEST-INFO | 1637: exit 0 03:10:26 INFO - Browser initialized. 03:10:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:26 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpaeG4Cy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:38 INFO - PROCESS | 1640 | RSS: Main: 163729408 03:10:38 INFO - PROCESS | 1640 | 03:13:40 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 03:13:42 INFO - PROCESS | 1640 | RSS: Main: 283602944 03:13:42 INFO - PROCESS | 1640 | 03:16:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 03:16:45 INFO - PROCESS | 1640 | RSS: Main: 307544064 03:16:45 INFO - PROCESS | 1640 | 03:19:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 03:19:48 INFO - PROCESS | 1640 | RSS: Main: 301768704 03:19:48 INFO - PROCESS | 1640 | 03:22:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 03:22:51 INFO - PROCESS | 1640 | RSS: Main: 286208000 03:22:51 INFO - PROCESS | 1640 | 03:25:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 03:25:55 INFO - PROCESS | 1640 | RSS: Main: 266678272 03:25:55 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 03:28:58 INFO - PROCESS | 1640 | RSS: Main: 513593344 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | __start_tp_report 03:28:58 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 03:28:58 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 03:28:58 INFO - PROCESS | 1640 | |i|pagename|runs| 03:28:58 INFO - PROCESS | 1640 | |0;dojo.html;3042.8630711617975;3498.8600455981764;3521.278137981714;3525.4006818840794;3532.6467353264675;4647.721136731799;4794.784234709437;5803.984302747018;5828.621139625927;5855.5022823060035;5778;5784.595078344518;5881.294244690643;5886;5900.114982752579;5018.447970723218;5232.869178270555;5281.207818827168;5322.2282768998475;5344.759485823128;4405.603495685387;5292.788288468457;5305.018571564254;5320.042392369372;5410.08028635131;5346.331708536433;5350.491703288201;5353.197020446925;5357.062514060043;5359.7320133993335;4378.233809083429;5285.127953887604;5288.153895376721;5306.018386598473;5386.326709161355;5248.9737551312;5317.813876514342;5319.840404787824;5328.0675881720545;5354.330708661418;4851.369321988119;5567.888642227133;5897.557683173779;5904.380040095771;6050.909236361458;6146.078088286748;6225.19072520574;6261.154744109533;6308.400701933355;6318.810435686937;6260.5304602154565;6282.685865706696;6310.7791227306825;6312.526560507934;6313.210848643919;6046.96976515119;6103.267607887037;6105.084237364386;6109.053096770008;6131.110988906584;6242.687865606701;6252.74989000444;6281.780137695158;6460.450861676716;6482.967585162044;6113.23584551931;6149.96925015372;6153.292371377349;6155.076738489173;6158.568900177034;6192.938070619326;6246.937530624727;6261.874762504815;6266.749330026748;6268.091126786681;6143.170671959318;6210.347913469111;6223.346548612421;6251.624902505864;6281;6276.874462510724;6302.243730752339;6314.747410103636;6322;6328.557001009885;5102.744862756847;5148.871278218075;5154.871128221825;5161.2516185152945;5175.948240517622;4612.446506419184;4614.676972611952;4619.260918253063;4633.328167415706;4641.071785642885;5880.852978675482;5959.404059594006;5996.5502587305255;6002.849928751729;6015.909761353583;6175.2589689237575;6268.529860260499;6285.685715714196;6299.307076221612;6316.210473690789;6034.758609655652;6056.36408177135;6071.210742603522;6093.512518998469;6098.298695650057;4982.900341993212;5312.335958005249;5535.612507124462;5592.720363981784;5605.7197140142825;6415.454686351619;6475.708593113227;6514.348565143448;6528.37980391862;6539;6278.717457714322;6283;6299.779507717208;6303.905441418474;6312.14786003902;6564.737410503526;6607.867842643216;6617.139771829631;6623.735050597922;6637.2699003108655;6169.290531588746;6240.625562466266;6250.937490625036;6289.811305660837;6323.588966717149;5789.1895134680335;5852.917210316105;6119.632822030692;6225.875482490234;6322.715477803418;6310.2743184534365;6317.463015643538;6325.05124231369;6333.904991425225;6355.205599300088;6323.936760632335;6331.366863313632;6343;6343.9365606343345;6348.174737284308;6078.088286757022;6230.563860529901;6233.937660623335;6234.096056071935;6244.65654389013;6159.84600384994;6212.844678882883;6236.781712640217;6270.592411493239;6314.147590075281;6196.907046394398;6219.844503887439;6224.844378890382;6225.533085018551;6250.531210159347 03:28:58 INFO - PROCESS | 1640 | |1;ext.html;506.55676283252154;517.1415450352416;518.2847670215103;529.2352550564436;537.089633071943;35671;44575;44606.776966115205;44793.55206447934;46803;45624;46442.303365449545;46500.30249546251;46536;46827.53172468274;9018.188363047324;9491.383060101105;9797.020297970217;9800.95099524505;9826.459544725072;9063.818723625523;11932.70168245792;12210.816837747396;12245.51017959285;12383.009359251238;11985.880141198608;12116.878831211707;12119.757604847899;12120.818187727147;12178.878211217863;10209.591616335338;12064.698382540419;12154.392280386033;12175;12177.33024683642;11947.283163010246;12043.397830108459;12045.63863084109;12058.397080145958;12067.034637229;41660;41768.582314176776;41774.37338439926;41842.58157418417;41964;4102.589741025903;4117.176564687044;4132.524759652649;4141.171765646883;4150.3566947123245;30904;31724;32560;32740.181495462803;33228.83385583081;3252.3820474109843;3395.7868748008814;3434.1414646338417;3462.394081035834;3462.5325581046486;491410;496639;496962;498609.50695246656;499670.5016474967;62445.37554624396;62743;62843.371566284666;62869.37130628726;62894.68552657299;67017.32982670209;67109;67147.32852671508;67197.66401167963;67330.66334668393;16334.938229015075;17215.82784172167;17842.821571784116;17885.7317140243;17917.910410447865;12509.687257818445;12714.173578717353;13755.724885502234;13795.241261730702;13820.308984550733;12516.81224781629;22094.88952555227;23298.53402931932;23317.183898563468;23418.531629367317;8844.292456603456;8989.741436198938;8999;9102.590383432762;9177.495237761987;897.228383590112;920.2545937790411;920.5489310238069;936.0405584276172;955.8614000969959;30464.238394040327;31338;31419;31944.02947913582;32575.185620359207;868.9044205137429;1084.739662480999;1096.0957210301533;1125.7692173104494;1247.5571172233908;15838.445654402041;16254.918725406535;16277;16517.554696528892;16585.751213731804;679457;682344;683621;684626;686344;64458.67770661211;65307;65327;65456.34543654598;65538;1258.534342293339;1361.9455221791216;1405.4799724102147;1529.06726896593;1531.663034132489;32167.6223996477;32924.67075329216;32935.01194964155;33020.83489582633;33620.1594960128;42855.785721071195;51736.74131629318;52371.47628523818;52393;52446.73776631092;435990.82004589774;437521;437717;437802;438088;37488.625113748516;38503.807480962416;38638.42042369423;45275.54724452713;45640.771796140805;49431.50568494269;49604;50439.24341134813;50703.74648126736;50907.745461272454;32671.30040177708;33882.66117338894;34088.318233634694;34853.12867178341;35079;27796.86101569479;32930.835345823114;33198;33649.66350336465;33832;39233.41149882697;39555.60444395634;39909.80947000523;40189;40426.989325265924;33102.50346244856;33540;33643.49534757029;33786.83106584451;34643.653563464046;26064;26096;26141.346466338495;26250.212493625222;26597.335066622716 03:28:58 INFO - PROCESS | 1640 | |2;jquery.html;377.7865505989116;400.49737579337926;405.69370125555207;411.15712788782986;411.6747769262283;20504.69242961357;21577.02903369348;21702.457438564044;21755.67366489504;21926.232581859636;10427.374357538534;10838.512266947986;11237.381943993078;11394.658160255185;22443.102275908986;5443.374011988622;5646.378898321182;5648.802291919784;5650.180723795047;5853.414658534134;6122.081687746829;6197.287311959138;6238.688065596702;6238.812835614916;6241.687915604224;5436.293281873351;5538.806141785039;6153.692315384235;6216.689165541728;6219.19150510433;5537.58468114893;5595.4124816894455;5596.104623260279;5598.216249725042;5610.607257491977;5284.128118860383;5410.594205434608;5476.424975377608;5511.58663100269;5512.641678290898;13810.723785524233;13929;13981.860181398157;14089.577312680534;14119.152850828983;2657.388800575859;2742.369255071325;2812.409394027257;2826.42058378032;2827.7455029047483;10184.217761891714;10443.477826108665;10473.690788651418;10620.840687389695;10762.139028877671;1819.8271164239377;1859.302761464451;1888.745019422374;1901.4105627255594;1915.1477592471356;121076;123953;126945;128811;130041;11992.760144797056;12040.170559918412;12181.817272740916;12225.327606981524;12380.752384952431;16343.221652319135;16374.426895058616;16375.344986200656;16406;16409.42567010173;8785.956070219736;9112.81774364509;9133.90866091344;9246.630134794668;9253.861192082124;7549.849003019909;8728.869066964;8899.707108369816;8917.910820891708;9105.907291125108;4812.446568644651;4897.314375987365;4907.460179380265;5001.799928002912;5015.122353588107;1757.745126956584;1983.9702404463944;2056.794320567931;2068.596623658402;2069.906854191565;1026.6509386808373;1047.120418848171;1052.9359563669836;1053.9262251642313;1084.4740300954031;19246.518837029187;21091.578168436547;22080;22348.553028939332;22430.990605422794;972.561993353492;986.2898712926682;1002.5288114586133;1087.8313861351503;1111.3276467737064;10474.423906685206;10808.379192970442;11577.421128943519;11636.88363116358;11647.359395233343;742376;745880;749698;753277;767628;92494.53752731193;132965;142954.28522857526;148493.25753371164;153705;1064.69123954054;1081.2917539012117;1106.446776611694;1108.3737688206138;1110.7889500994786;19712;19753.209871604973;20387.4903127423;20405.693914590996;20511.79488205099;44382.55617443784;51696.741516292175;57927;58897.411025889196;59145.22564323077;84446;85957.57021215104;86904;90193.54903225442;90413;8455;8473.279771219515;8540.017897941816;8735;8743.475391476532;12563.560275390317;13241.891557316167;13421.932890335485;13430.328483575977;13572.93213533926;11235.382053987109;11288.379139147097;11678.766424671629;11717.88282117168;11753.882461175279;10522;10560.630377936735;10592.311499752492;10628.787424251626;10747.785044299226;11311.830322545004;11371.488283027118;11456.713582160513;11478.024367928485;11877.990370818578;8195.67217311301;8369.95815020921;8617.741467755977;8713.564321783759;8737;11135.164862635173;11138.610148645083;11188;11610.88389116098;11702.122340824642 03:28:58 INFO - PROCESS | 1640 | |3;mootools.html;1448.0949406620862;1483.5549335199437;1502.308937888571;1510.403390660689;1512.7503961846292;8183.3862460315495;8559.972803263609;8562.700305489301;8566.914330856705;8573.571321433934;6360.650164240965;7559.357454616351;7748.418868584865;8287.08842027378;8381.413301068927;2307.884605769709;2327.7323107842562;2348.8473249238746;2352.6706261123454;2356.8821558921986;2257.909683612662;2277.829162812787;2288.107638021165;2298.1267118494948;2302.4128847143957;2291.3584196425027;2300.298408985259;2313.7686231376897;2317.2700599311165;2318.802901753353;2351.814249579673;2353.788159065684;2365.136725095345;2375.5842727522786;2376.7266764322067;2371.359732872115;2372.7305891348046;2395.0300128448007;2398.220578312038;2398.6761787158684;8324.958375208145;8391.874121888115;8434.915650843535;8438.57807109642;8456.154384561556;4994.550490455877;5127.230915362688;5289.603279753996;5293.41772405039;5299.867503312409;3413.9658603414146;3578.874739384109;3600.6939410150167;3648.2521083177885;3652.9269414611827;1206.8129439936824;1255.6860784803798;1276.961691149267;1300.603315988623;1304.8890844278249;10839.67480975572;10926.235163538555;10930.070943969773;10936.945315273453;10946.56213751457;4386.649068074546;4703.811847526129;4757.976210118927;4784.904301913943;4790.9220425404;9416.670416535526;9546.570404331822;9562.378445401027;9583.808323833484;9598.472084035446;4647.721136731807;5309.070912590281;5311.150215965427;5312.893742125136;5313.973430132824;3753.8123093845197;4365.148795984816;4408.867733967986;4792.424909010941;4854.635902307341;3870.3807390817333;3915.7846318452757;3974.2647610192207;4002.579729128458;4006.659433948089;1266.1010682415588;1270.783966725659;1271.7456508698297;1279.1685404487157;1285.6216000399186;911.589784596934;939.2439086535268;954.5799848066829;963.2679163835395;995.6180880555747;5553.555715542747;5650.208970744099;5802.361740208574;5809.099589563624;5903.704814759245;571.7398583644432;581.3198557687516;586.1178925716769;592.6769910398843;599.5713065158433;3792.639699228569;3800.771953682788;3804.1250512382308;3886.1644746379666;3909.4722212500947;9628.277879158952;10070.597176112873;10093.949530252448;10100.494975251355;10121.392716437038;10063.496825158712;10073.1437827784;10073.546690398949;10074.59701611942;10077.29458937882;7860.292573668397;7925.801854953557;7938.3252423544645;7963.641636126388;7999.400044996649;4605.286180642006;5420.7560659769615;5555.972220138873;5722.399148089391;5733.541316694738;8895.644174232959;9201.815963680556;9245.953770231106;9326.860097098413;9390.24878009744;9406.905930940877;9427.481488518197;9451.95274023653;9616.423014618866;9657.517124143624;6729.226138994079;6735.528513004238;6940.02839602446;7248.130224373109;7388.076490438695;7790.415718820997;7926.445148839526;7997.440179187401;8083.8383232333845;8099.068607110258;6810.795676129724;7011.368976792113;7011.579305241702;7077.5399599025895;7117.181524124792;6758.86482270342;6916.654167291515;6926.688299026455;6943.062686537252;6974.302569742985;6324.367563243639;6444;6509;6521.804345869631;6565.441937435371;4665.953340466552;4997.900461898376;5053.469385714594;5072.137736584863;5087.058894104603;4803.351547541037;5005.424376196638;5099.79600815978;5145.92281115776;5151.356080489939 03:28:58 INFO - PROCESS | 1640 | |4;prototype.html;366.7029705938189;366.94862719219316;377.251156454438;381.29079911364875;386.46667598713753;4434.5343738907395;4442.711223770452;5340.62615616907;5348.956953394085;5388.838334849961;4773.665843390955;4967.168713833107;5040.143175660138;5040.546350828425;5376.516113549789;3635.999999999993;4207.263728847454;4231.597998190167;4236.830526778926;4270.530241673413;3851.0372406898277;4217.954292168311;4231.682623803212;4245.9575404246025;4253.659707223414;3392.7455440841914;4189.916201675965;4207.789610519477;4234.475588788034;4244.320908654616;3728.6576832340334;4190.177272886304;4196.706230563862;4223.13425747721;4249.978750106246;3632.654897784706;3785.886423407302;3800.467934489174;3806.71449641278;3810.5617853946874;4953.752312384367;5239.397469291042;5317.760700768475;5348.893022139574;5382.519807053052;4322.848700295506;4882.609391248691;4917.852464426073;4941.160002799496;4987.900241995139;4827.927581086286;5814.476697097281;5846.912296315559;5854.736536855852;5890.293164820249;4151.782170358013;4160.54234034256;4241.830326786925;4249.766262855542;4259.595338442843;5916.946891379419;5985.940140598582;5996.580239383201;6032.547558933054;6044.758209671608;4264.530901600821;4272.166927449118;4274.465691788527;4286.571342865751;4305.5048669402795;4029.657479114308;4357.039332300477;4373.803178856895;4382.715123516961;4384.649228061748;4251.44731184944;4335.544767799399;4927.802887884516;4952.925706114411;4972.651914366032;4883.780229889663;5153.433122356538;5722.828315150552;5819.272590926134;5863.941360586425;1165.9591914283128;1333;1338.43785610044;1416.2706206303762;1434.634168287101;990.8662330585279;1005.5525291245472;1011.9797604048025;1020.2195320579763;1025.7025462615907;4697.976510117496;4805.711657300573;5100.260462232955;5174.9482505174465;5182.404023537266;5697.6296540724725;5758.193852860602;5764.596478246483;5764.625299355528;5765.299236725176;4306.609831543461;4382.912341753211;4821.108095002436;5054.267131265946;5271.947280527223;2364.4443555764383;2758.462099890542;2770.6952235254107;2830.895950579276;2957.645082590103;5446.833172622946;5596.776128954878;5599.720013999284;5801.303843538718;6016.338202797689;5380.461953804588;5954.910676339859;6027.367126451747;6067.817965461043;6080.695965201722;5687.60186786921;6198.2871969723155;6203.96898015507;6261.497240662299;6273.9372606273355;4622.745748983703;5239.659422137549;5723.910772568066;5767.414905150332;5837.67892765902;5061.911688986886;5269.814291784472;5770.374479611851;5825.854353641193;5873.295204575307;4955.479674634255;5479.150731636602;5843;6097.725602347994;6126.95841706902;3393.694567488938;3874.825632846472;3904.7657140571655;3937.251922134785;3954.4859168307935;5607.22442391019;5719.628224165416;5746.310442746897;5838.540364908773;5862.4791339724325;4778.832740854054;4999.425066117443;5214.374275086862;5321.920171197357;5695.914561281501;4349.434573505424;4967.503249675004;5687.60186786921;5694.800681976111;5720.456556627114;5018.749062546931;5382.596305277041;5457.544105152777;5620.831375058591;5660.915086273627;4528.501864794804;5076.857707015892;5665.291838520185;5696.971515142398;5749.655020698771;5386.946130538801;5546.556275498031;5584.916226256528;5590.916136257878;5600.747966341443 03:28:58 INFO - PROCESS | 1640 | |5;yui.html;750.9962450187749;777.961101944903;803.6182813163748;868.405142477403;875.4440930009445;15088.999999999985;15112.395504179833;15831.762523562142;16052.11713355765;16064.437744678939;14355.71288574228;14532.636684082903;14557;14794.704105917903;14829.629259268524;884.8451520983834;896.1218006353777;904.263025634106;905.2169873059789;907.8048219632777;724.2865777209445;749.8500299940007;874.8731433942074;900.6082354175954;903.9548022598876;955.1117460761488;964.662368171138;964.8070385922844;965.4110992294694;969.9515024248794;957.5308099031494;957.6121670723368;958.8322043642404;959.6593209410663;964.1467301438242;709.6770969208998;713.7965679781289;714.7176865138241;714.8320144765976;717.5336031579515;12328.876711232862;15367.15480648564;15518.534443966699;15767.684646307009;15869;12409.441575129142;14768.556943291718;15442.227888605525;15524.223788810627;15630.921845390814;11934.701632459171;11975.46110425033;11997.121088030128;12212.389380530938;12262.570810021696;3796.3925771876643;3853.865114720971;3862.517185351831;3872.5159355080614;3947.2697550953167;109555.45222273837;113096.43451782688;113557;115666;117213.41393293065;11627.244229125079;11817.940910295394;11860.346737730893;12048.578299759467;12324.691882703004;24607.13875014366;24883.87558062198;25082;25095.121670741803;25328.366790830376;6998.68505917235;8220.8355832883;8235.21765432283;8450.239478446969;8504;4448.666350023761;4471.776411179493;4525.954740452619;4590.265557510782;4624.30635404692;3659.341318562684;3794.430835374716;3867.5165604299464;3867.61323867611;3869.980650096788;676.7597502886503;679.9048133261348;683.2654895986834;695.6278391060758;699.7830672491544;693.3893889506014;720.1718024272129;720.2545365546739;753.7625647920887;759.8927795266593;10021.348612340174;10533.525991330256;10582.730072391209;10671.679849604525;10677.412742299248;660.3000819131736;672.794797586731;678.3352314731591;685.5715178013742;691.5919607431639;5062.949370506321;5064.670796398223;5167.664101833444;5174.379074511007;5525.668459892419;73997.6300118496;90321;105265;106991;108266;82263.17736822675;87663.56168219246;94270.58594121094;95351;96853;73135;86356;86554;87578.68631970526;87931;9583.664571739955;10776.946115269688;11228.326300422;11383;11518.712032199262;45129.32306015347;46746;48912.510874890795;50253.21075233345;51559.71100722362;50942.235866462775;70833;71445.5710885769;72613;74965.62517187379;12839.358032098544;13217.942564594618;13316.600501984569;13564.796528052284;14348.354324055234;14774;15471.071735695894;15635.374585016927;15675.529734107995;15884.12637304913;14044.926971178653;14175.43298268099;14444.566663000127;14656.633584160481;14816.62958426048;13755.17468951866;13815.032947693566;14444.783328249874;14583.635409114857;15075.47235846784;12008.699782505508;12614.55849045279;12652;13415.664608384479;13429;9885;9909.603615855573;10238.897611023795;10385.169186465217;10701.625443109453;8722.302215822592;10325;10633.830278669186;11680.824787628362;11968.16222864391 03:28:58 INFO - PROCESS | 1640 | __end_tp_report 03:28:58 INFO - PROCESS | 1640 | __start_cc_report 03:28:58 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2118 03:28:58 INFO - PROCESS | 1640 | __end_cc_report 03:28:58 INFO - PROCESS | 1640 | __startTimestamp1491474538835__endTimestamp 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | ------- Summary: start ------- 03:28:58 INFO - PROCESS | 1640 | Number of tests: 6 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5846.92 Median:6149.97 stddev:676.05 (11.0%) stddev-sans-first:641.34 03:28:58 INFO - PROCESS | 1640 | Values: 3042.9 3498.9 3521.3 3525.4 3532.6 4647.7 4794.8 5804.0 5828.6 5855.5 5778.0 5784.6 5881.3 5886.0 5900.1 5018.4 5232.9 5281.2 5322.2 5344.8 4405.6 5292.8 5305.0 5320.0 5410.1 5346.3 5350.5 5353.2 5357.1 5359.7 4378.2 5285.1 5288.2 5306.0 5386.3 5249.0 5317.8 5319.8 5328.1 5354.3 4851.4 5567.9 5897.6 5904.4 6050.9 6146.1 6225.2 6261.2 6308.4 6318.8 6260.5 6282.7 6310.8 6312.5 6313.2 6047.0 6103.3 6105.1 6109.1 6131.1 6242.7 6252.7 6281.8 6460.5 6483.0 6113.2 6150.0 6153.3 6155.1 6158.6 6192.9 6246.9 6261.9 6266.7 6268.1 6143.2 6210.3 6223.3 6251.6 6281.0 6276.9 6302.2 6314.7 6322.0 6328.6 5102.7 5148.9 5154.9 5161.3 5175.9 4612.4 4614.7 4619.3 4633.3 4641.1 5880.9 5959.4 5996.6 6002.8 6015.9 6175.3 6268.5 6285.7 6299.3 6316.2 6034.8 6056.4 6071.2 6093.5 6098.3 4982.9 5312.3 5535.6 5592.7 5605.7 6415.5 6475.7 6514.3 6528.4 6539.0 6278.7 6283.0 6299.8 6303.9 6312.1 6564.7 6607.9 6617.1 6623.7 6637.3 6169.3 6240.6 6250.9 6289.8 6323.6 5789.2 5852.9 6119.6 6225.9 6322.7 6310.3 6317.5 6325.1 6333.9 6355.2 6323.9 6331.4 6343.0 6343.9 6348.2 6078.1 6230.6 6233.9 6234.1 6244.7 6159.8 6212.8 6236.8 6270.6 6314.1 6196.9 6219.8 6224.8 6225.5 6250.5 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:69281.66 Median:38571.11 stddev:146474.81 (379.8%) stddev-sans-first:146794.69 03:28:58 INFO - PROCESS | 1640 | Values: 506.6 517.1 518.3 529.2 537.1 35671.0 44575.0 44606.8 44793.6 46803.0 45624.0 46442.3 46500.3 46536.0 46827.5 9018.2 9491.4 9797.0 9801.0 9826.5 9063.8 11932.7 12210.8 12245.5 12383.0 11985.9 12116.9 12119.8 12120.8 12178.9 10209.6 12064.7 12154.4 12175.0 12177.3 11947.3 12043.4 12045.6 12058.4 12067.0 41660.0 41768.6 41774.4 41842.6 41964.0 4102.6 4117.2 4132.5 4141.2 4150.4 30904.0 31724.0 32560.0 32740.2 33228.8 3252.4 3395.8 3434.1 3462.4 3462.5 491410.0 496639.0 496962.0 498609.5 499670.5 62445.4 62743.0 62843.4 62869.4 62894.7 67017.3 67109.0 67147.3 67197.7 67330.7 16334.9 17215.8 17842.8 17885.7 17917.9 12509.7 12714.2 13755.7 13795.2 13820.3 12516.8 22094.9 23298.5 23317.2 23418.5 8844.3 8989.7 8999.0 9102.6 9177.5 897.2 920.3 920.5 936.0 955.9 30464.2 31338.0 31419.0 31944.0 32575.2 868.9 1084.7 1096.1 1125.8 1247.6 15838.4 16254.9 16277.0 16517.6 16585.8 679457.0 682344.0 683621.0 684626.0 686344.0 64458.7 65307.0 65327.0 65456.3 65538.0 1258.5 1361.9 1405.5 1529.1 1531.7 32167.6 32924.7 32935.0 33020.8 33620.2 42855.8 51736.7 52371.5 52393.0 52446.7 435990.8 437521.0 437717.0 437802.0 438088.0 37488.6 38503.8 38638.4 45275.5 45640.8 49431.5 49604.0 50439.2 50703.7 50907.7 32671.3 33882.7 34088.3 34853.1 35079.0 27796.9 32930.8 33198.0 33649.7 33832.0 39233.4 39555.6 39909.8 40189.0 40427.0 33102.5 33540.0 33643.5 33786.8 34643.7 26064.0 26096.0 26141.3 26250.2 26597.3 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:39769.84 Median:2062.70 stddev:124727.25 (6046.8%) stddev-sans-first:125042.07 03:28:58 INFO - PROCESS | 1640 | Values: 377.8 400.5 405.7 411.2 411.7 20504.7 21577.0 21702.5 21755.7 21926.2 10427.4 10838.5 11237.4 11394.7 22443.1 5443.4 5646.4 5648.8 5650.2 5853.4 6122.1 6197.3 6238.7 6238.8 6241.7 5436.3 5538.8 6153.7 6216.7 6219.2 5537.6 5595.4 5596.1 5598.2 5610.6 5284.1 5410.6 5476.4 5511.6 5512.6 13810.7 13929.0 13981.9 14089.6 14119.2 2657.4 2742.4 2812.4 2826.4 2827.7 10184.2 10443.5 10473.7 10620.8 10762.1 1819.8 1859.3 1888.7 1901.4 1915.1 121076.0 123953.0 126945.0 128811.0 130041.0 11992.8 12040.2 12181.8 12225.3 12380.8 16343.2 16374.4 16375.3 16406.0 16409.4 8786.0 9112.8 9133.9 9246.6 9253.9 7549.8 8728.9 8899.7 8917.9 9105.9 4812.4 4897.3 4907.5 5001.8 5015.1 1757.7 1984.0 2056.8 2068.6 2069.9 1026.7 1047.1 1052.9 1053.9 1084.5 19246.5 21091.6 22080.0 22348.6 22431.0 972.6 986.3 1002.5 1087.8 1111.3 10474.4 10808.4 11577.4 11636.9 11647.4 742376.0 745880.0 749698.0 753277.0 767628.0 92494.5 132965.0 142954.3 148493.3 153705.0 1064.7 1081.3 1106.4 1108.4 1110.8 19712.0 19753.2 20387.5 20405.7 20511.8 44382.6 51696.7 57927.0 58897.4 59145.2 84446.0 85957.6 86904.0 90193.5 90413.0 8455.0 8473.3 8540.0 8735.0 8743.5 12563.6 13241.9 13421.9 13430.3 13572.9 11235.4 11288.4 11678.8 11717.9 11753.9 10522.0 10560.6 10592.3 10628.8 10747.8 11311.8 11371.5 11456.7 11478.0 11878.0 8195.7 8370.0 8617.7 8713.6 8737.0 11135.2 11138.6 11188.0 11610.9 11702.1 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5456.33 Median:5136.58 stddev:2978.62 (58.0%) stddev-sans-first:2971.74 03:28:58 INFO - PROCESS | 1640 | Values: 1448.1 1483.6 1502.3 1510.4 1512.8 8183.4 8560.0 8562.7 8566.9 8573.6 6360.7 7559.4 7748.4 8287.1 8381.4 2307.9 2327.7 2348.8 2352.7 2356.9 2257.9 2277.8 2288.1 2298.1 2302.4 2291.4 2300.3 2313.8 2317.3 2318.8 2351.8 2353.8 2365.1 2375.6 2376.7 2371.4 2372.7 2395.0 2398.2 2398.7 8325.0 8391.9 8434.9 8438.6 8456.2 4994.6 5127.2 5289.6 5293.4 5299.9 3414.0 3578.9 3600.7 3648.3 3652.9 1206.8 1255.7 1277.0 1300.6 1304.9 10839.7 10926.2 10930.1 10936.9 10946.6 4386.6 4703.8 4758.0 4784.9 4790.9 9416.7 9546.6 9562.4 9583.8 9598.5 4647.7 5309.1 5311.2 5312.9 5314.0 3753.8 4365.1 4408.9 4792.4 4854.6 3870.4 3915.8 3974.3 4002.6 4006.7 1266.1 1270.8 1271.7 1279.2 1285.6 911.6 939.2 954.6 963.3 995.6 5553.6 5650.2 5802.4 5809.1 5903.7 571.7 581.3 586.1 592.7 599.6 3792.6 3800.8 3804.1 3886.2 3909.5 9628.3 10070.6 10093.9 10100.5 10121.4 10063.5 10073.1 10073.5 10074.6 10077.3 7860.3 7925.8 7938.3 7963.6 7999.4 4605.3 5420.8 5556.0 5722.4 5733.5 8895.6 9201.8 9246.0 9326.9 9390.2 9406.9 9427.5 9452.0 9616.4 9657.5 6729.2 6735.5 6940.0 7248.1 7388.1 7790.4 7926.4 7997.4 8083.8 8099.1 6810.8 7011.4 7011.6 7077.5 7117.2 6758.9 6916.7 6926.7 6943.1 6974.3 6324.4 6444.0 6509.0 6521.8 6565.4 4666.0 4997.9 5053.5 5072.1 5087.1 4803.4 5005.4 5099.8 5145.9 5151.4 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4629.98 Median:4980.28 stddev:1383.89 (27.8%) stddev-sans-first:1350.27 03:28:58 INFO - PROCESS | 1640 | Values: 366.7 366.9 377.3 381.3 386.5 4434.5 4442.7 5340.6 5349.0 5388.8 4773.7 4967.2 5040.1 5040.5 5376.5 3636.0 4207.3 4231.6 4236.8 4270.5 3851.0 4218.0 4231.7 4246.0 4253.7 3392.7 4189.9 4207.8 4234.5 4244.3 3728.7 4190.2 4196.7 4223.1 4250.0 3632.7 3785.9 3800.5 3806.7 3810.6 4953.8 5239.4 5317.8 5348.9 5382.5 4322.8 4882.6 4917.9 4941.2 4987.9 4827.9 5814.5 5846.9 5854.7 5890.3 4151.8 4160.5 4241.8 4249.8 4259.6 5916.9 5985.9 5996.6 6032.5 6044.8 4264.5 4272.2 4274.5 4286.6 4305.5 4029.7 4357.0 4373.8 4382.7 4384.6 4251.4 4335.5 4927.8 4952.9 4972.7 4883.8 5153.4 5722.8 5819.3 5863.9 1166.0 1333.0 1338.4 1416.3 1434.6 990.9 1005.6 1012.0 1020.2 1025.7 4698.0 4805.7 5100.3 5174.9 5182.4 5697.6 5758.2 5764.6 5764.6 5765.3 4306.6 4382.9 4821.1 5054.3 5271.9 2364.4 2758.5 2770.7 2830.9 2957.6 5446.8 5596.8 5599.7 5801.3 6016.3 5380.5 5954.9 6027.4 6067.8 6080.7 5687.6 6198.3 6204.0 6261.5 6273.9 4622.7 5239.7 5723.9 5767.4 5837.7 5061.9 5269.8 5770.4 5825.9 5873.3 4955.5 5479.2 5843.0 6097.7 6127.0 3393.7 3874.8 3904.8 3937.3 3954.5 5607.2 5719.6 5746.3 5838.5 5862.5 4778.8 4999.4 5214.4 5321.9 5695.9 4349.4 4967.5 5687.6 5694.8 5720.5 5018.7 5382.6 5457.5 5620.8 5660.9 4528.5 5076.9 5665.3 5697.0 5749.7 5386.9 5546.6 5584.9 5590.9 5600.7 03:28:58 INFO - PROCESS | 1640 | 03:28:58 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:21045.11 Median:3868.80 stddev:30172.57 (779.9%) stddev-sans-first:30218.74 03:28:58 INFO - PROCESS | 1640 | Values: 751.0 778.0 803.6 868.4 875.4 15089.0 15112.4 15831.8 16052.1 16064.4 14355.7 14532.6 14557.0 14794.7 14829.6 884.8 896.1 904.3 905.2 907.8 724.3 749.9 874.9 900.6 904.0 955.1 964.7 964.8 965.4 970.0 957.5 957.6 958.8 959.7 964.1 709.7 713.8 714.7 714.8 717.5 12328.9 15367.2 15518.5 15767.7 15869.0 12409.4 14768.6 15442.2 15524.2 15630.9 11934.7 11975.5 11997.1 12212.4 12262.6 3796.4 3853.9 3862.5 3872.5 3947.3 109555.5 113096.4 113557.0 115666.0 117213.4 11627.2 11817.9 11860.3 12048.6 12324.7 24607.1 24883.9 25082.0 25095.1 25328.4 6998.7 8220.8 8235.2 8450.2 8504.0 4448.7 4471.8 4526.0 4590.3 4624.3 3659.3 3794.4 3867.5 3867.6 3870.0 676.8 679.9 683.3 695.6 699.8 693.4 720.2 720.3 753.8 759.9 10021.3 10533.5 10582.7 10671.7 10677.4 660.3 672.8 678.3 685.6 691.6 5062.9 5064.7 5167.7 5174.4 5525.7 73997.6 90321.0 105265.0 106991.0 108266.0 82263.2 87663.6 94270.6 95351.0 96853.0 73135.0 86356.0 86554.0 87578.7 87931.0 9583.7 10776.9 11228.3 11383.0 11518.7 45129.3 46746.0 48912.5 50253.2 51559.7 50942.2 70833.0 71445.6 72613.0 74965.6 12839.4 13217.9 13316.6 13564.8 14348.4 14774.0 15471.1 15635.4 15675.5 15884.1 14044.9 14175.4 14444.6 14656.6 14816.6 13755.2 13815.0 14444.8 14583.6 15075.5 12008.7 12614.6 12652.0 13415.7 13429.0 9885.0 9909.6 10238.9 10385.2 10701.6 8722.3 10325.0 10633.8 11680.8 11968.2 03:28:58 INFO - PROCESS | 1640 | -------- Summary: end -------- 03:28:58 INFO - PROCESS | 1640 | 03:28:59 INFO - TEST-INFO | 1640: exit 0 03:28:59 INFO - TEST-OK | dromaeo_css | took 1116621ms 03:28:59 INFO - TEST-START | kraken 03:28:59 INFO - operating with platform_type : mac_ 03:28:59 INFO - Initialising browser for kraken test... 03:28:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmphh924V/profile http://localhost:49249/getInfo.html) 03:29:01 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 03:29:01 INFO - PROCESS | 1649 | colorDepth:24 03:29:01 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 03:29:01 INFO - PROCESS | 1649 | __metrics 03:29:01 INFO - PROCESS | 1649 | 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" 03:29:01 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:02 INFO - TEST-INFO | 1649: exit 0 03:29:02 INFO - Browser initialized. 03:29:02 INFO - Running cycle 1/1 for kraken test... 03:29:02 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmphh924V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:14 INFO - PROCESS | 1651 | RSS: Main: 167739392 03:29:14 INFO - PROCESS | 1651 | 03:29:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:18 INFO - PROCESS | 1651 | RSS: Main: 215199744 03:29:18 INFO - PROCESS | 1651 | 03:29:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 03:29:21 INFO - PROCESS | 1651 | RSS: Main: 229298176 03:29:21 INFO - PROCESS | 1651 | 03:29:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 03:29:25 INFO - PROCESS | 1651 | RSS: Main: 326377472 03:29:25 INFO - PROCESS | 1651 | 03:29:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 03:29:27 INFO - PROCESS | 1651 | RSS: Main: 226697216 03:29:27 INFO - PROCESS | 1651 | 03:29:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:30 INFO - PROCESS | 1651 | RSS: Main: 227483648 03:29:30 INFO - PROCESS | 1651 | 03:29:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:33 INFO - PROCESS | 1651 | RSS: Main: 268525568 03:29:33 INFO - PROCESS | 1651 | 03:29:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:37 INFO - PROCESS | 1651 | RSS: Main: 269561856 03:29:37 INFO - PROCESS | 1651 | 03:29:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 03:29:40 INFO - PROCESS | 1651 | RSS: Main: 266899456 03:29:40 INFO - PROCESS | 1651 | 03:29:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:42 INFO - PROCESS | 1651 | RSS: Main: 244559872 03:29:42 INFO - PROCESS | 1651 | 03:29:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:45 INFO - PROCESS | 1651 | RSS: Main: 248684544 03:29:45 INFO - PROCESS | 1651 | 03:29:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:48 INFO - PROCESS | 1651 | RSS: Main: 252915712 03:29:48 INFO - PROCESS | 1651 | 03:29:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:51 INFO - PROCESS | 1651 | RSS: Main: 270782464 03:29:51 INFO - PROCESS | 1651 | 03:29:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:55 INFO - PROCESS | 1651 | RSS: Main: 264777728 03:29:55 INFO - PROCESS | 1651 | 03:29:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 03:29:57 INFO - PROCESS | 1651 | RSS: Main: 309305344 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | __start_tp_report 03:29:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 03:29:57 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 03:29:57 INFO - PROCESS | 1651 | |i|pagename|runs| 03:29:57 INFO - PROCESS | 1651 | |0;ai-astar;112;114;114;113;113;114;113;113;114;113 03:29:57 INFO - PROCESS | 1651 | |1;audio-beat-detection;165;134;136;142;107;107;105;107;126;107 03:29:57 INFO - PROCESS | 1651 | |2;audio-dft;181;198;260;207;183;181;183;180;180;181 03:29:57 INFO - PROCESS | 1651 | |3;audio-fft;81;58;57;89;58;59;58;58;72;57 03:29:57 INFO - PROCESS | 1651 | |4;audio-oscillator;87;72;85;70;68;68;81;67;69;80 03:29:57 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;86;88;86;88;86;89;86;88;107 03:29:57 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;94;94;95;93;95;93;93;93 03:29:57 INFO - PROCESS | 1651 | |7;imaging-desaturate;87;87;84;85;85;85;102;131;84;86 03:29:57 INFO - PROCESS | 1651 | |8;json-parse-financial;54;52;52;56;56;54;55;56;55;55 03:29:57 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;79;77;78;78;97;98;94;71;70 03:29:57 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;81;84;85;96;99;99;98;75;82;87 03:29:57 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;134;143;141;131;126;132;137;136;166;142 03:29:57 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;163;163;167;162;161;163;161;160;161 03:29:57 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;63;66;65;65;63;62;64;62;63 03:29:57 INFO - PROCESS | 1651 | __end_tp_report 03:29:57 INFO - PROCESS | 1651 | __start_cc_report 03:29:57 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2084 03:29:57 INFO - PROCESS | 1651 | __end_cc_report 03:29:57 INFO - PROCESS | 1651 | __startTimestamp1491474597115__endTimestamp 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | ------- Summary: start ------- 03:29:57 INFO - PROCESS | 1651 | Number of tests: 14 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 03:29:57 INFO - PROCESS | 1651 | Values: 112.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:130.00 stddev:20.46 (15.7%) stddev-sans-first:15.26 03:29:57 INFO - PROCESS | 1651 | Values: 165.0 134.0 136.0 142.0 107.0 107.0 105.0 107.0 126.0 107.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:193.40 Median:183.00 stddev:25.12 (13.7%) stddev-sans-first:26.24 03:29:57 INFO - PROCESS | 1651 | Values: 181.0 198.0 260.0 207.0 183.0 181.0 183.0 180.0 180.0 181.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:64.70 Median:58.50 stddev:11.74 (20.1%) stddev-sans-first:10.87 03:29:57 INFO - PROCESS | 1651 | Values: 81.0 58.0 57.0 89.0 58.0 59.0 58.0 58.0 72.0 57.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:76.00 stddev:7.72 (10.2%) stddev-sans-first:6.78 03:29:57 INFO - PROCESS | 1651 | Values: 87.0 72.0 85.0 70.0 68.0 68.0 81.0 67.0 69.0 80.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:88.00 stddev:6.34 (7.2%) stddev-sans-first:6.73 03:29:57 INFO - PROCESS | 1651 | Values: 89.0 86.0 88.0 86.0 88.0 86.0 89.0 86.0 88.0 107.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:29:57 INFO - PROCESS | 1651 | Values: 94.0 93.0 94.0 94.0 95.0 93.0 95.0 93.0 93.0 93.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:85.00 stddev:14.83 (17.5%) stddev-sans-first:15.64 03:29:57 INFO - PROCESS | 1651 | Values: 87.0 87.0 84.0 85.0 85.0 85.0 102.0 131.0 84.0 86.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 03:29:57 INFO - PROCESS | 1651 | Values: 54.0 52.0 52.0 56.0 56.0 54.0 55.0 56.0 55.0 55.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:78.50 stddev:11.26 (14.3%) stddev-sans-first:10.92 03:29:57 INFO - PROCESS | 1651 | Values: 68.0 79.0 77.0 78.0 78.0 97.0 98.0 94.0 71.0 70.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:91.50 stddev:8.71 (9.5%) stddev-sans-first:8.79 03:29:57 INFO - PROCESS | 1651 | Values: 81.0 84.0 85.0 96.0 99.0 99.0 98.0 75.0 82.0 87.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:139.00 stddev:10.94 (7.9%) stddev-sans-first:11.47 03:29:57 INFO - PROCESS | 1651 | Values: 134.0 143.0 141.0 131.0 126.0 132.0 137.0 136.0 166.0 142.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:1.95 (1.2%) stddev-sans-first:2.06 03:29:57 INFO - PROCESS | 1651 | Values: 162.0 163.0 163.0 167.0 162.0 161.0 163.0 161.0 160.0 161.0 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 03:29:57 INFO - PROCESS | 1651 | Values: 64.0 63.0 66.0 65.0 65.0 63.0 62.0 64.0 62.0 63.0 03:29:57 INFO - PROCESS | 1651 | -------- Summary: end -------- 03:29:57 INFO - PROCESS | 1651 | 03:29:57 INFO - TEST-INFO | 1651: exit 0 03:29:57 INFO - TEST-OK | kraken | took 58528ms 03:29:57 INFO - SUITE-END | took 1175s 03:29:58 INFO - Completed test suite (00:19:35) 03:29:58 INFO - javascript benchmark 03:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.8630711617975, 3498.8600455981764, 3521.278137981714, 3525.4006818840794, 3532.6467353264675, 4647.721136731799, 4794.784234709437, 5803.984302747018, 5828.621139625927, 5855.5022823060035, 5778.0, 5784.595078344518, 5881.294244690643, 5886.0, 5900.114982752579, 5018.447970723218, 5232.869178270555, 5281.207818827168, 5322.2282768998475, 5344.759485823128, 4405.603495685387, 5292.788288468457, 5305.018571564254, 5320.042392369372, 5410.08028635131, 5346.331708536433, 5350.491703288201, 5353.197020446925, 5357.062514060043, 5359.7320133993335, 4378.233809083429, 5285.127953887604, 5288.153895376721, 5306.018386598473, 5386.326709161355, 5248.9737551312, 5317.813876514342, 5319.840404787824, 5328.0675881720545, 5354.330708661418, 4851.369321988119, 5567.888642227133, 5897.557683173779, 5904.380040095771, 6050.909236361458, 6146.078088286748, 6225.19072520574, 6261.154744109533, 6308.400701933355, 6318.810435686937, 6260.5304602154565, 6282.685865706696, 6310.7791227306825, 6312.526560507934, 6313.210848643919, 6046.96976515119, 6103.267607887037, 6105.084237364386, 6109.053096770008, 6131.110988906584, 6242.687865606701, 6252.74989000444, 6281.780137695158, 6460.450861676716, 6482.967585162044, 6113.23584551931, 6149.96925015372, 6153.292371377349, 6155.076738489173, 6158.568900177034, 6192.938070619326, 6246.937530624727, 6261.874762504815, 6266.749330026748, 6268.091126786681, 6143.170671959318, 6210.347913469111, 6223.346548612421, 6251.624902505864, 6281.0, 6276.874462510724, 6302.243730752339, 6314.747410103636, 6322.0, 6328.557001009885, 5102.744862756847, 5148.871278218075, 5154.871128221825, 5161.2516185152945, 5175.948240517622, 4612.446506419184, 4614.676972611952, 4619.260918253063, 4633.328167415706, 4641.071785642885, 5880.852978675482, 5959.404059594006, 5996.5502587305255, 6002.849928751729, 6015.909761353583, 6175.2589689237575, 6268.529860260499, 6285.685715714196, 6299.307076221612, 6316.210473690789, 6034.758609655652, 6056.36408177135, 6071.210742603522, 6093.512518998469, 6098.298695650057, 4982.900341993212, 5312.335958005249, 5535.612507124462, 5592.720363981784, 5605.7197140142825, 6415.454686351619, 6475.708593113227, 6514.348565143448, 6528.37980391862, 6539.0, 6278.717457714322, 6283.0, 6299.779507717208, 6303.905441418474, 6312.14786003902, 6564.737410503526, 6607.867842643216, 6617.139771829631, 6623.735050597922, 6637.2699003108655, 6169.290531588746, 6240.625562466266, 6250.937490625036, 6289.811305660837, 6323.588966717149, 5789.1895134680335, 5852.917210316105, 6119.632822030692, 6225.875482490234, 6322.715477803418, 6310.2743184534365, 6317.463015643538, 6325.05124231369, 6333.904991425225, 6355.205599300088, 6323.936760632335, 6331.366863313632, 6343.0, 6343.9365606343345, 6348.174737284308, 6078.088286757022, 6230.563860529901, 6233.937660623335, 6234.096056071935, 6244.65654389013, 6159.84600384994, 6212.844678882883, 6236.781712640217, 6270.592411493239, 6314.147590075281, 6196.907046394398, 6219.844503887439, 6224.844378890382, 6225.533085018551, 6250.531210159347], "value": 5803.873704230261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.55676283252154, 517.1415450352416, 518.2847670215103, 529.2352550564436, 537.089633071943, 35671.0, 44575.0, 44606.776966115205, 44793.55206447934, 46803.0, 45624.0, 46442.303365449545, 46500.30249546251, 46536.0, 46827.53172468274, 9018.188363047324, 9491.383060101105, 9797.020297970217, 9800.95099524505, 9826.459544725072, 9063.818723625523, 11932.70168245792, 12210.816837747396, 12245.51017959285, 12383.009359251238, 11985.880141198608, 12116.878831211707, 12119.757604847899, 12120.818187727147, 12178.878211217863, 10209.591616335338, 12064.698382540419, 12154.392280386033, 12175.0, 12177.33024683642, 11947.283163010246, 12043.397830108459, 12045.63863084109, 12058.397080145958, 12067.034637229, 41660.0, 41768.582314176776, 41774.37338439926, 41842.58157418417, 41964.0, 4102.589741025903, 4117.176564687044, 4132.524759652649, 4141.171765646883, 4150.3566947123245, 30904.0, 31724.0, 32560.0, 32740.181495462803, 33228.83385583081, 3252.3820474109843, 3395.7868748008814, 3434.1414646338417, 3462.394081035834, 3462.5325581046486, 491410.0, 496639.0, 496962.0, 498609.50695246656, 499670.5016474967, 62445.37554624396, 62743.0, 62843.371566284666, 62869.37130628726, 62894.68552657299, 67017.32982670209, 67109.0, 67147.32852671508, 67197.66401167963, 67330.66334668393, 16334.938229015075, 17215.82784172167, 17842.821571784116, 17885.7317140243, 17917.910410447865, 12509.687257818445, 12714.173578717353, 13755.724885502234, 13795.241261730702, 13820.308984550733, 12516.81224781629, 22094.88952555227, 23298.53402931932, 23317.183898563468, 23418.531629367317, 8844.292456603456, 8989.741436198938, 8999.0, 9102.590383432762, 9177.495237761987, 897.228383590112, 920.2545937790411, 920.5489310238069, 936.0405584276172, 955.8614000969959, 30464.238394040327, 31338.0, 31419.0, 31944.02947913582, 32575.185620359207, 868.9044205137429, 1084.739662480999, 1096.0957210301533, 1125.7692173104494, 1247.5571172233908, 15838.445654402041, 16254.918725406535, 16277.0, 16517.554696528892, 16585.751213731804, 679457.0, 682344.0, 683621.0, 684626.0, 686344.0, 64458.67770661211, 65307.0, 65327.0, 65456.34543654598, 65538.0, 1258.534342293339, 1361.9455221791216, 1405.4799724102147, 1529.06726896593, 1531.663034132489, 32167.6223996477, 32924.67075329216, 32935.01194964155, 33020.83489582633, 33620.1594960128, 42855.785721071195, 51736.74131629318, 52371.47628523818, 52393.0, 52446.73776631092, 435990.82004589774, 437521.0, 437717.0, 437802.0, 438088.0, 37488.625113748516, 38503.807480962416, 38638.42042369423, 45275.54724452713, 45640.771796140805, 49431.50568494269, 49604.0, 50439.24341134813, 50703.74648126736, 50907.745461272454, 32671.30040177708, 33882.66117338894, 34088.318233634694, 34853.12867178341, 35079.0, 27796.86101569479, 32930.835345823114, 33198.0, 33649.66350336465, 33832.0, 39233.41149882697, 39555.60444395634, 39909.80947000523, 40189.0, 40426.989325265924, 33102.50346244856, 33540.0, 33643.49534757029, 33786.83106584451, 34643.653563464046, 26064.0, 26096.0, 26141.346466338495, 26250.212493625222, 26597.335066622716], "value": 21296.059702729654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7865505989116, 400.49737579337926, 405.69370125555207, 411.15712788782986, 411.6747769262283, 20504.69242961357, 21577.02903369348, 21702.457438564044, 21755.67366489504, 21926.232581859636, 10427.374357538534, 10838.512266947986, 11237.381943993078, 11394.658160255185, 22443.102275908986, 5443.374011988622, 5646.378898321182, 5648.802291919784, 5650.180723795047, 5853.414658534134, 6122.081687746829, 6197.287311959138, 6238.688065596702, 6238.812835614916, 6241.687915604224, 5436.293281873351, 5538.806141785039, 6153.692315384235, 6216.689165541728, 6219.19150510433, 5537.58468114893, 5595.4124816894455, 5596.104623260279, 5598.216249725042, 5610.607257491977, 5284.128118860383, 5410.594205434608, 5476.424975377608, 5511.58663100269, 5512.641678290898, 13810.723785524233, 13929.0, 13981.860181398157, 14089.577312680534, 14119.152850828983, 2657.388800575859, 2742.369255071325, 2812.409394027257, 2826.42058378032, 2827.7455029047483, 10184.217761891714, 10443.477826108665, 10473.690788651418, 10620.840687389695, 10762.139028877671, 1819.8271164239377, 1859.302761464451, 1888.745019422374, 1901.4105627255594, 1915.1477592471356, 121076.0, 123953.0, 126945.0, 128811.0, 130041.0, 11992.760144797056, 12040.170559918412, 12181.817272740916, 12225.327606981524, 12380.752384952431, 16343.221652319135, 16374.426895058616, 16375.344986200656, 16406.0, 16409.42567010173, 8785.956070219736, 9112.81774364509, 9133.90866091344, 9246.630134794668, 9253.861192082124, 7549.849003019909, 8728.869066964, 8899.707108369816, 8917.910820891708, 9105.907291125108, 4812.446568644651, 4897.314375987365, 4907.460179380265, 5001.799928002912, 5015.122353588107, 1757.745126956584, 1983.9702404463944, 2056.794320567931, 2068.596623658402, 2069.906854191565, 1026.6509386808373, 1047.120418848171, 1052.9359563669836, 1053.9262251642313, 1084.4740300954031, 19246.518837029187, 21091.578168436547, 22080.0, 22348.553028939332, 22430.990605422794, 972.561993353492, 986.2898712926682, 1002.5288114586133, 1087.8313861351503, 1111.3276467737064, 10474.423906685206, 10808.379192970442, 11577.421128943519, 11636.88363116358, 11647.359395233343, 742376.0, 745880.0, 749698.0, 753277.0, 767628.0, 92494.53752731193, 132965.0, 142954.28522857526, 148493.25753371164, 153705.0, 1064.69123954054, 1081.2917539012117, 1106.446776611694, 1108.3737688206138, 1110.7889500994786, 19712.0, 19753.209871604973, 20387.4903127423, 20405.693914590996, 20511.79488205099, 44382.55617443784, 51696.741516292175, 57927.0, 58897.411025889196, 59145.22564323077, 84446.0, 85957.57021215104, 86904.0, 90193.54903225442, 90413.0, 8455.0, 8473.279771219515, 8540.017897941816, 8735.0, 8743.475391476532, 12563.560275390317, 13241.891557316167, 13421.932890335485, 13430.328483575977, 13572.93213533926, 11235.382053987109, 11288.379139147097, 11678.766424671629, 11717.88282117168, 11753.882461175279, 10522.0, 10560.630377936735, 10592.311499752492, 10628.787424251626, 10747.785044299226, 11311.830322545004, 11371.488283027118, 11456.713582160513, 11478.024367928485, 11877.990370818578, 8195.67217311301, 8369.95815020921, 8617.741467755977, 8713.564321783759, 8737.0, 11135.164862635173, 11138.610148645083, 11188.0, 11610.88389116098, 11702.122340824642], "value": 9787.489336638768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.0949406620862, 1483.5549335199437, 1502.308937888571, 1510.403390660689, 1512.7503961846292, 8183.3862460315495, 8559.972803263609, 8562.700305489301, 8566.914330856705, 8573.571321433934, 6360.650164240965, 7559.357454616351, 7748.418868584865, 8287.08842027378, 8381.413301068927, 2307.884605769709, 2327.7323107842562, 2348.8473249238746, 2352.6706261123454, 2356.8821558921986, 2257.909683612662, 2277.829162812787, 2288.107638021165, 2298.1267118494948, 2302.4128847143957, 2291.3584196425027, 2300.298408985259, 2313.7686231376897, 2317.2700599311165, 2318.802901753353, 2351.814249579673, 2353.788159065684, 2365.136725095345, 2375.5842727522786, 2376.7266764322067, 2371.359732872115, 2372.7305891348046, 2395.0300128448007, 2398.220578312038, 2398.6761787158684, 8324.958375208145, 8391.874121888115, 8434.915650843535, 8438.57807109642, 8456.154384561556, 4994.550490455877, 5127.230915362688, 5289.603279753996, 5293.41772405039, 5299.867503312409, 3413.9658603414146, 3578.874739384109, 3600.6939410150167, 3648.2521083177885, 3652.9269414611827, 1206.8129439936824, 1255.6860784803798, 1276.961691149267, 1300.603315988623, 1304.8890844278249, 10839.67480975572, 10926.235163538555, 10930.070943969773, 10936.945315273453, 10946.56213751457, 4386.649068074546, 4703.811847526129, 4757.976210118927, 4784.904301913943, 4790.9220425404, 9416.670416535526, 9546.570404331822, 9562.378445401027, 9583.808323833484, 9598.472084035446, 4647.721136731807, 5309.070912590281, 5311.150215965427, 5312.893742125136, 5313.973430132824, 3753.8123093845197, 4365.148795984816, 4408.867733967986, 4792.424909010941, 4854.635902307341, 3870.3807390817333, 3915.7846318452757, 3974.2647610192207, 4002.579729128458, 4006.659433948089, 1266.1010682415588, 1270.783966725659, 1271.7456508698297, 1279.1685404487157, 1285.6216000399186, 911.589784596934, 939.2439086535268, 954.5799848066829, 963.2679163835395, 995.6180880555747, 5553.555715542747, 5650.208970744099, 5802.361740208574, 5809.099589563624, 5903.704814759245, 571.7398583644432, 581.3198557687516, 586.1178925716769, 592.6769910398843, 599.5713065158433, 3792.639699228569, 3800.771953682788, 3804.1250512382308, 3886.1644746379666, 3909.4722212500947, 9628.277879158952, 10070.597176112873, 10093.949530252448, 10100.494975251355, 10121.392716437038, 10063.496825158712, 10073.1437827784, 10073.546690398949, 10074.59701611942, 10077.29458937882, 7860.292573668397, 7925.801854953557, 7938.3252423544645, 7963.641636126388, 7999.400044996649, 4605.286180642006, 5420.7560659769615, 5555.972220138873, 5722.399148089391, 5733.541316694738, 8895.644174232959, 9201.815963680556, 9245.953770231106, 9326.860097098413, 9390.24878009744, 9406.905930940877, 9427.481488518197, 9451.95274023653, 9616.423014618866, 9657.517124143624, 6729.226138994079, 6735.528513004238, 6940.02839602446, 7248.130224373109, 7388.076490438695, 7790.415718820997, 7926.445148839526, 7997.440179187401, 8083.8383232333845, 8099.068607110258, 6810.795676129724, 7011.368976792113, 7011.579305241702, 7077.5399599025895, 7117.181524124792, 6758.86482270342, 6916.654167291515, 6926.688299026455, 6943.062686537252, 6974.302569742985, 6324.367563243639, 6444.0, 6509.0, 6521.804345869631, 6565.441937435371, 4665.953340466552, 4997.900461898376, 5053.469385714594, 5072.137736584863, 5087.058894104603, 4803.351547541037, 5005.424376196638, 5099.79600815978, 5145.92281115776, 5151.356080489939], "value": 4408.073204216378, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.7029705938189, 366.94862719219316, 377.251156454438, 381.29079911364875, 386.46667598713753, 4434.5343738907395, 4442.711223770452, 5340.62615616907, 5348.956953394085, 5388.838334849961, 4773.665843390955, 4967.168713833107, 5040.143175660138, 5040.546350828425, 5376.516113549789, 3635.999999999993, 4207.263728847454, 4231.597998190167, 4236.830526778926, 4270.530241673413, 3851.0372406898277, 4217.954292168311, 4231.682623803212, 4245.9575404246025, 4253.659707223414, 3392.7455440841914, 4189.916201675965, 4207.789610519477, 4234.475588788034, 4244.320908654616, 3728.6576832340334, 4190.177272886304, 4196.706230563862, 4223.13425747721, 4249.978750106246, 3632.654897784706, 3785.886423407302, 3800.467934489174, 3806.71449641278, 3810.5617853946874, 4953.752312384367, 5239.397469291042, 5317.760700768475, 5348.893022139574, 5382.519807053052, 4322.848700295506, 4882.609391248691, 4917.852464426073, 4941.160002799496, 4987.900241995139, 4827.927581086286, 5814.476697097281, 5846.912296315559, 5854.736536855852, 5890.293164820249, 4151.782170358013, 4160.54234034256, 4241.830326786925, 4249.766262855542, 4259.595338442843, 5916.946891379419, 5985.940140598582, 5996.580239383201, 6032.547558933054, 6044.758209671608, 4264.530901600821, 4272.166927449118, 4274.465691788527, 4286.571342865751, 4305.5048669402795, 4029.657479114308, 4357.039332300477, 4373.803178856895, 4382.715123516961, 4384.649228061748, 4251.44731184944, 4335.544767799399, 4927.802887884516, 4952.925706114411, 4972.651914366032, 4883.780229889663, 5153.433122356538, 5722.828315150552, 5819.272590926134, 5863.941360586425, 1165.9591914283128, 1333.0, 1338.43785610044, 1416.2706206303762, 1434.634168287101, 990.8662330585279, 1005.5525291245472, 1011.9797604048025, 1020.2195320579763, 1025.7025462615907, 4697.976510117496, 4805.711657300573, 5100.260462232955, 5174.9482505174465, 5182.404023537266, 5697.6296540724725, 5758.193852860602, 5764.596478246483, 5764.625299355528, 5765.299236725176, 4306.609831543461, 4382.912341753211, 4821.108095002436, 5054.267131265946, 5271.947280527223, 2364.4443555764383, 2758.462099890542, 2770.6952235254107, 2830.895950579276, 2957.645082590103, 5446.833172622946, 5596.776128954878, 5599.720013999284, 5801.303843538718, 6016.338202797689, 5380.461953804588, 5954.910676339859, 6027.367126451747, 6067.817965461043, 6080.695965201722, 5687.60186786921, 6198.2871969723155, 6203.96898015507, 6261.497240662299, 6273.9372606273355, 4622.745748983703, 5239.659422137549, 5723.910772568066, 5767.414905150332, 5837.67892765902, 5061.911688986886, 5269.814291784472, 5770.374479611851, 5825.854353641193, 5873.295204575307, 4955.479674634255, 5479.150731636602, 5843.0, 6097.725602347994, 6126.95841706902, 3393.694567488938, 3874.825632846472, 3904.7657140571655, 3937.251922134785, 3954.4859168307935, 5607.22442391019, 5719.628224165416, 5746.310442746897, 5838.540364908773, 5862.4791339724325, 4778.832740854054, 4999.425066117443, 5214.374275086862, 5321.920171197357, 5695.914561281501, 4349.434573505424, 4967.503249675004, 5687.60186786921, 5694.800681976111, 5720.456556627114, 5018.749062546931, 5382.596305277041, 5457.544105152777, 5620.831375058591, 5660.915086273627, 4528.501864794804, 5076.857707015892, 5665.291838520185, 5696.971515142398, 5749.655020698771, 5386.946130538801, 5546.556275498031, 5584.916226256528, 5590.916136257878, 5600.747966341443], "value": 4212.151545351304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.9962450187749, 777.961101944903, 803.6182813163748, 868.405142477403, 875.4440930009445, 15088.999999999985, 15112.395504179833, 15831.762523562142, 16052.11713355765, 16064.437744678939, 14355.71288574228, 14532.636684082903, 14557.0, 14794.704105917903, 14829.629259268524, 884.8451520983834, 896.1218006353777, 904.263025634106, 905.2169873059789, 907.8048219632777, 724.2865777209445, 749.8500299940007, 874.8731433942074, 900.6082354175954, 903.9548022598876, 955.1117460761488, 964.662368171138, 964.8070385922844, 965.4110992294694, 969.9515024248794, 957.5308099031494, 957.6121670723368, 958.8322043642404, 959.6593209410663, 964.1467301438242, 709.6770969208998, 713.7965679781289, 714.7176865138241, 714.8320144765976, 717.5336031579515, 12328.876711232862, 15367.15480648564, 15518.534443966699, 15767.684646307009, 15869.0, 12409.441575129142, 14768.556943291718, 15442.227888605525, 15524.223788810627, 15630.921845390814, 11934.701632459171, 11975.46110425033, 11997.121088030128, 12212.389380530938, 12262.570810021696, 3796.3925771876643, 3853.865114720971, 3862.517185351831, 3872.5159355080614, 3947.2697550953167, 109555.45222273837, 113096.43451782688, 113557.0, 115666.0, 117213.41393293065, 11627.244229125079, 11817.940910295394, 11860.346737730893, 12048.578299759467, 12324.691882703004, 24607.13875014366, 24883.87558062198, 25082.0, 25095.121670741803, 25328.366790830376, 6998.68505917235, 8220.8355832883, 8235.21765432283, 8450.239478446969, 8504.0, 4448.666350023761, 4471.776411179493, 4525.954740452619, 4590.265557510782, 4624.30635404692, 3659.341318562684, 3794.430835374716, 3867.5165604299464, 3867.61323867611, 3869.980650096788, 676.7597502886503, 679.9048133261348, 683.2654895986834, 695.6278391060758, 699.7830672491544, 693.3893889506014, 720.1718024272129, 720.2545365546739, 753.7625647920887, 759.8927795266593, 10021.348612340174, 10533.525991330256, 10582.730072391209, 10671.679849604525, 10677.412742299248, 660.3000819131736, 672.794797586731, 678.3352314731591, 685.5715178013742, 691.5919607431639, 5062.949370506321, 5064.670796398223, 5167.664101833444, 5174.379074511007, 5525.668459892419, 73997.6300118496, 90321.0, 105265.0, 106991.0, 108266.0, 82263.17736822675, 87663.56168219246, 94270.58594121094, 95351.0, 96853.0, 73135.0, 86356.0, 86554.0, 87578.68631970526, 87931.0, 9583.664571739955, 10776.946115269688, 11228.326300422, 11383.0, 11518.712032199262, 45129.32306015347, 46746.0, 48912.510874890795, 50253.21075233345, 51559.71100722362, 50942.235866462775, 70833.0, 71445.5710885769, 72613.0, 74965.62517187379, 12839.358032098544, 13217.942564594618, 13316.600501984569, 13564.796528052284, 14348.354324055234, 14774.0, 15471.071735695894, 15635.374585016927, 15675.529734107995, 15884.12637304913, 14044.926971178653, 14175.43298268099, 14444.566663000127, 14656.633584160481, 14816.62958426048, 13755.17468951866, 13815.032947693566, 14444.783328249874, 14583.635409114857, 15075.47235846784, 12008.699782505508, 12614.55849045279, 12652.0, 13415.664608384479, 13429.0, 9885.0, 9909.603615855573, 10238.897611023795, 10385.169186465217, 10701.625443109453, 8722.302215822592, 10325.0, 10633.830278669186, 11680.824787628362, 11968.16222864391], "value": 7809.642247233392, "unit": "score"}], "name": "dromaeo_css", "value": 7482.042388986748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 136.0, 142.0, 107.0, 107.0, 105.0, 107.0, 126.0, 107.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 198.0, 260.0, 207.0, 183.0, 181.0, 183.0, 180.0, 180.0, 181.0], "value": 193.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 57.0, 89.0, 58.0, 59.0, 58.0, 58.0, 72.0, 57.0], "value": 64.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 85.0, 70.0, 68.0, 68.0, 81.0, 67.0, 69.0, 80.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 86.0, 89.0, 86.0, 88.0, 107.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 95.0, 93.0, 95.0, 93.0, 93.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 84.0, 85.0, 85.0, 85.0, 102.0, 131.0, 84.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 56.0, 56.0, 54.0, 55.0, 56.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 77.0, 78.0, 78.0, 97.0, 98.0, 94.0, 71.0, 70.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 85.0, 96.0, 99.0, 99.0, 98.0, 75.0, 82.0, 87.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 141.0, 131.0, 126.0, 132.0, 137.0, 136.0, 166.0, 142.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 167.0, 162.0, 161.0, 163.0, 161.0, 160.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 65.0, 65.0, 63.0, 62.0, 64.0, 62.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1433.1999999999998, "alertThreshold": 2.0}]} 03:29:58 INFO - Return code: 0 03:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:29:58 INFO - # TBPL SUCCESS # 03:29:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:58 INFO - 2017-04-06 03:29:58.443 screenresolution[1655:9694] starting screenresolution argv=screenresolution get 03:29:58 INFO - 2017-04-06 03:29:58.445 screenresolution[1655:9694] Display 0: 1600x1200x32@60 03:29:58 INFO - 2017-04-06 03:29:58.451 screenresolution[1656:9697] starting screenresolution argv=screenresolution list 03:29:58 INFO - Available Modes on Display 0 03:29:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:58 INFO - Intel Iris: 03:29:58 INFO - Chipset Model: Intel Iris 03:29:58 INFO - Type: GPU 03:29:58 INFO - Bus: Built-In 03:29:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:58 INFO - Vendor: Intel (0x8086) 03:29:58 INFO - Device ID: 0x0a2e 03:29:58 INFO - Revision ID: 0x0009 03:29:58 INFO - Displays: 03:29:58 INFO - Display: 03:29:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:58 INFO - Display Serial Number: 1600x1200 60 03:29:58 INFO - Main Display: Yes 03:29:58 INFO - Mirror: Off 03:29:58 INFO - Online: Yes 03:29:58 INFO - Rotation: Supported 03:29:58 INFO - Return code: 0 03:29:58 INFO - Running post-action listener: _resource_record_post_action 03:29:58 INFO - [mozharness: 2017-04-06 10:29:58.686684Z] Finished run-tests step (success) 03:29:58 INFO - Running post-run listener: _resource_record_post_run 03:29:58 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38286336; Write bytes: 420737536; Read time: 243; Write time: 1361 03:29:58 INFO - TinderboxPrint: CPU usage
53.6% 03:29:58 INFO - TinderboxPrint: I/O read bytes / time
38,286,336 / 243 03:29:58 INFO - TinderboxPrint: I/O write bytes / time
420,737,536 / 1,361 03:29:58 INFO - TinderboxPrint: CPU idle
2,209.3 (46.4%) 03:29:58 INFO - TinderboxPrint: CPU system
955.2 (20.1%) 03:29:58 INFO - TinderboxPrint: CPU user
1,597.2 (33.5%) 03:29:58 INFO - TinderboxPrint: Swap in / out
160,186,368 / 0 03:29:58 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111925760; Write bytes: 103157760; Read time: 10036; Write time: 220 03:29:58 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37352448; Write bytes: 298086912; Read time: 230; Write time: 1083 03:29:59 INFO - Running post-run listener: _upload_blobber_files 03:29:59 INFO - Blob upload gear active. 03:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:59 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 03:29:59 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'] 03:29:59 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 03:29:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:00 INFO - (blobuploader) - INFO - Done attempting. 03:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:01 INFO - (blobuploader) - INFO - Done attempting. 03:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:02 INFO - (blobuploader) - INFO - Done attempting. 03:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:04 INFO - (blobuploader) - INFO - Done attempting. 03:30:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:04 INFO - Return code: 0 03:30:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adda30dd823cfd312f1f95d0d1556631d7e48eb4a642d004c36f8cb3f9bbd2a214e3f24bc6cb9c098d800c2d71b334d21c976047a03cca3fc9fdd8652e4742f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e62c8b9d1bbc2f9fa39d7eb71cf9a8ecc1091d5e9ce2ec8eebe539a4fe6fbef6a68dbb35545ac84f63d0cb755b52e7c0a27094be049043f3eea4df1f519ed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05f910bad191af9f072a790d638e6ec398cba3e2be27b1dd5de2192462f0050c44f5a2606512bad9bd64ff1c49e482f62077ca4fb36b3b2df4afc35c8332c392", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a64eb964c2f4d0001b1242389ca7024e2907c5ddb4c2e903bbc668957bc089efd8a0d5b07c2c0bb3cfef6222d6ee700506e7b4d12ee34635546fe071611928e6"} 03:30:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:04 INFO - Contents: 03:30:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/adda30dd823cfd312f1f95d0d1556631d7e48eb4a642d004c36f8cb3f9bbd2a214e3f24bc6cb9c098d800c2d71b334d21c976047a03cca3fc9fdd8652e4742f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e62c8b9d1bbc2f9fa39d7eb71cf9a8ecc1091d5e9ce2ec8eebe539a4fe6fbef6a68dbb35545ac84f63d0cb755b52e7c0a27094be049043f3eea4df1f519ed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05f910bad191af9f072a790d638e6ec398cba3e2be27b1dd5de2192462f0050c44f5a2606512bad9bd64ff1c49e482f62077ca4fb36b3b2df4afc35c8332c392", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a64eb964c2f4d0001b1242389ca7024e2907c5ddb4c2e903bbc668957bc089efd8a0d5b07c2c0bb3cfef6222d6ee700506e7b4d12ee34635546fe071611928e6"} 03:30:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:04 INFO - Copying logs to upload dir... 03:30:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.567792 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 03:30:04.646982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 03:30:04.650622) ========= 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.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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/adda30dd823cfd312f1f95d0d1556631d7e48eb4a642d004c36f8cb3f9bbd2a214e3f24bc6cb9c098d800c2d71b334d21c976047a03cca3fc9fdd8652e4742f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e62c8b9d1bbc2f9fa39d7eb71cf9a8ecc1091d5e9ce2ec8eebe539a4fe6fbef6a68dbb35545ac84f63d0cb755b52e7c0a27094be049043f3eea4df1f519ed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05f910bad191af9f072a790d638e6ec398cba3e2be27b1dd5de2192462f0050c44f5a2606512bad9bd64ff1c49e482f62077ca4fb36b3b2df4afc35c8332c392", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a64eb964c2f4d0001b1242389ca7024e2907c5ddb4c2e903bbc668957bc089efd8a0d5b07c2c0bb3cfef6222d6ee700506e7b4d12ee34635546fe071611928e6"} build_url:https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/Zgz1Z3IYTcuah717tWMFKQ/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/adda30dd823cfd312f1f95d0d1556631d7e48eb4a642d004c36f8cb3f9bbd2a214e3f24bc6cb9c098d800c2d71b334d21c976047a03cca3fc9fdd8652e4742f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36e62c8b9d1bbc2f9fa39d7eb71cf9a8ecc1091d5e9ce2ec8eebe539a4fe6fbef6a68dbb35545ac84f63d0cb755b52e7c0a27094be049043f3eea4df1f519ed0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05f910bad191af9f072a790d638e6ec398cba3e2be27b1dd5de2192462f0050c44f5a2606512bad9bd64ff1c49e482f62077ca4fb36b3b2df4afc35c8332c392", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a64eb964c2f4d0001b1242389ca7024e2907c5ddb4c2e903bbc668957bc089efd8a0d5b07c2c0bb3cfef6222d6ee700506e7b4d12ee34635546fe071611928e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 03:30:04.686077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:30:04.686420) ========= 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.Qlb5OnBBvM/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.40h7x35qhF/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.005185 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 03:30:04.735266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 03:30:04.735595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 03:30:04.735966) ========= ========= Total master_lag: 2.24 =========