builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0083 starttime: 1484963968.71 results: success (0) buildid: 20170120154124 builduid: 9f8ade4d99d74edc804d377723a41209 revision: b9613014ba65c40a78227be03c69e993c70f96ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.705734) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.706235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.706557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.733403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.733790) ========= 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.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-20 17:59:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.0M=0s 2017-01-20 17:59:28 (25.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.881819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.882237) ========= 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.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.026537 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.930683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:28.931027) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9613014ba65c40a78227be03c69e993c70f96ad --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-aurora --rev b9613014ba65c40a78227be03c69e993c70f96ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-20 17:59:29,031 truncating revision to first 12 chars 2017-01-20 17:59:29,032 Setting DEBUG logging. 2017-01-20 17:59:29,032 attempt 1/10 2017-01-20 17:59:29,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9613014ba65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 17:59:29,624 unpacking tar archive at: mozilla-aurora-b9613014ba65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:29.814195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:29.814518) ========= script_repo_revision: b9613014ba65c40a78227be03c69e993c70f96ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:29.814946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:29.815267) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 17:59:29.835012) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-20 17:59:29.835406) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 17:59:30 INFO - MultiFileLogger online at 20170120 17:59:30 in /builds/slave/test 17:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:59:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:30 INFO - {'append_to_log': False, 17:59:30 INFO - 'base_work_dir': '/builds/slave/test', 17:59:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:30 INFO - 'branch': 'Mozilla-Aurora', 17:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:30 INFO - 'config_files': ('talos/mac_config.py',), 17:59:30 INFO - 'default_actions': ('clobber', 17:59:30 INFO - 'read-buildbot-config', 17:59:30 INFO - 'download-and-extract', 17:59:30 INFO - 'populate-webroot', 17:59:30 INFO - 'create-virtualenv', 17:59:30 INFO - 'install', 17:59:30 INFO - 'run-tests'), 17:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:30 INFO - 'download_minidump_stackwalk': True, 17:59:30 INFO - 'download_symbols': 'ondemand', 17:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 17:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 17:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:30 INFO - 'installer_path': 'installer.exe', 17:59:30 INFO - 'log_level': 'info', 17:59:30 INFO - 'log_name': 'talos', 17:59:30 INFO - 'log_to_console': True, 17:59:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:59:30 INFO - 'opt_config_files': (), 17:59:30 INFO - 'pip_index': False, 17:59:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:30 INFO - 'cmd': ('bash', 17:59:30 INFO - '-c', 17:59:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:30 INFO - 'enabled': True, 17:59:30 INFO - 'halt_on_failure': False, 17:59:30 INFO - 'name': 'check_screen_resolution'},), 17:59:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:59:30 INFO - 'cmd': ('bash', 17:59:30 INFO - '-c', 17:59:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:59:30 INFO - 'enabled': True, 17:59:30 INFO - 'halt_on_failure': False, 17:59:30 INFO - 'name': 'check_screen_resolution'},), 17:59:30 INFO - 'run_cmd_checks_enabled': True, 17:59:30 INFO - 'sps_profile': False, 17:59:30 INFO - 'sps_profile_interval': 0, 17:59:30 INFO - 'suite': 'dromaeojs', 17:59:30 INFO - 'system_bits': '32', 17:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:30 INFO - 'title': 't-yosemite-r7-0083', 17:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:30 INFO - 'use_talos_json': True, 17:59:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:30 INFO - 'work_dir': 'build'} 17:59:30 INFO - [mozharness: 2017-01-21 01:59:30.046230Z] Running clobber step. 17:59:30 INFO - Running pre-action listener: _resource_record_pre_action 17:59:30 INFO - Running main action method: clobber 17:59:30 INFO - rmtree: /builds/slave/test/build 17:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:32 INFO - Running post-action listener: _resource_record_post_action 17:59:32 INFO - [mozharness: 2017-01-21 01:59:32.450821Z] Finished clobber step (success) 17:59:32 INFO - [mozharness: 2017-01-21 01:59:32.450960Z] Running read-buildbot-config step. 17:59:32 INFO - Running pre-action listener: _resource_record_pre_action 17:59:32 INFO - Running main action method: read_buildbot_config 17:59:32 INFO - Using buildbot properties: 17:59:32 INFO - { 17:59:32 INFO - "project": "", 17:59:32 INFO - "product": "firefox", 17:59:32 INFO - "script_repo_revision": "production", 17:59:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:59:32 INFO - "repository": "", 17:59:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:59:32 INFO - "buildid": "20170120154124", 17:59:32 INFO - "pgo_build": "False", 17:59:32 INFO - "basedir": "/builds/slave/test", 17:59:32 INFO - "buildnumber": 27, 17:59:32 INFO - "slavename": "t-yosemite-r7-0083", 17:59:32 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:59:32 INFO - "platform": "yosemite_r7", 17:59:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:59:32 INFO - "branch": "mozilla-aurora", 17:59:32 INFO - "repo_path": "releases/mozilla-aurora", 17:59:32 INFO - "revision": "b9613014ba65c40a78227be03c69e993c70f96ad", 17:59:32 INFO - "stage_platform": "macosx64", 17:59:32 INFO - "builduid": "9f8ade4d99d74edc804d377723a41209", 17:59:32 INFO - "slavebuilddir": "test" 17:59:32 INFO - } 17:59:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 17:59:32 INFO - Running post-action listener: _resource_record_post_action 17:59:32 INFO - [mozharness: 2017-01-21 01:59:32.455064Z] Finished read-buildbot-config step (success) 17:59:32 INFO - [mozharness: 2017-01-21 01:59:32.455209Z] Running download-and-extract step. 17:59:32 INFO - Running pre-action listener: _resource_record_pre_action 17:59:32 INFO - Running main action method: download_and_extract 17:59:32 INFO - mkdir: /builds/slave/test/build/tests 17:59:32 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')]} 17:59:32 INFO - trying https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 17:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 17:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 17:59:33 INFO - Downloaded 1199 bytes. 17:59:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 17:59:33 INFO - Using the following test package requirements: 17:59:33 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 17:59:33 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 17:59:33 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 17:59:33 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'jsshell-mac.zip'], 17:59:33 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 17:59:33 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 17:59:33 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 17:59:33 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 17:59:33 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 17:59:33 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 17:59:33 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 17:59:33 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:59:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 17:59:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:59:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 17:59:34 INFO - Http code: 200 17:59:34 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 17:59:34 INFO - x-amz-cf-id: lX0YYkvIkhfIDN5cm6NvP6psxxdOcJjkA-Lts6dBKFWQaGPPkf_wzA== 17:59:34 INFO - x-amz-version-id: Yv1KjJGgVtug2Cad4JqlKjSShqpisBrH 17:59:34 INFO - Expected file size: 16276206 17:59:34 INFO - Obtained file size: 16276206 17:59:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:59:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 17:59:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:59:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 17:59:41 INFO - Http code: 200 17:59:41 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 17:59:41 INFO - x-amz-cf-id: W5ceIJquKhmbs5wEqDbVV0mf9ji0ldMLgkphhqjM-OJ9YfINYtnL9w== 17:59:41 INFO - x-amz-version-id: Yv1KjJGgVtug2Cad4JqlKjSShqpisBrH 17:59:42 INFO - Expected file size: 16276206 17:59:42 INFO - Obtained file size: 16276206 17:59:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 17:59:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:59:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 17:59:49 INFO - Http code: 200 17:59:49 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 17:59:49 INFO - x-amz-cf-id: k003Gxl7t8PsgSgnkrp2pEeXYKp5fiHpNdGauszT7zqZNX5DODpkEA== 17:59:49 INFO - x-amz-version-id: nCGJ7bFj6qSRpmWTCkaAqY9FD634y2FG 17:59:49 INFO - Expected file size: 14402992 17:59:49 INFO - Obtained file size: 14402992 17:59: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')]} 17:59:50 INFO - trying https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:59:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 17:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 17:59:52 INFO - Downloaded 110615054 bytes. 17:59:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:59:52 INFO - mkdir: /builds/slave/test/properties 17:59:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:59:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:59:52 INFO - Contents: 17:59:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 17:59:53 INFO - Running post-action listener: _resource_record_post_action 17:59:53 INFO - Running post-action listener: set_extra_try_arguments 17:59:53 INFO - [mozharness: 2017-01-21 01:59:53.525920Z] Finished download-and-extract step (success) 17:59:53 INFO - [mozharness: 2017-01-21 01:59:53.526043Z] Running populate-webroot step. 17:59:53 INFO - Running pre-action listener: _resource_record_pre_action 17:59:53 INFO - Running main action method: populate_webroot 17:59:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:59:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:59:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:59:53 INFO - '--tppagecycles', 17:59:53 INFO - '7'], 17:59:53 INFO - 'tests': ['tsvgm']}}, 17:59:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:59:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:59:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:59:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:59:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:59:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['damp', 'tps']}, 17:59:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'tests': ['damp', 'tps']}, 17:59:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['dromaeo_dom']}, 17:59:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:59:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['basic_compositor_video']}, 17:59:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:59:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['a11yr', 17:59:53 INFO - 'ts_paint', 17:59:53 INFO - 'tpaint', 17:59:53 INFO - 'sessionrestore', 17:59:53 INFO - 'sessionrestore_no_auto_restore', 17:59:53 INFO - 'tabpaint']}, 17:59:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['tsvgx', 17:59:53 INFO - 'tsvgr_opacity', 17:59:53 INFO - 'tart', 17:59:53 INFO - 'tscrollx', 17:59:53 INFO - 'cart']}, 17:59:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:59:53 INFO - 'tsvgr_opacity', 17:59:53 INFO - 'tart', 17:59:53 INFO - 'tscrollx', 17:59:53 INFO - 'cart']}, 17:59:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'talos_options': ['--disable-e10s'], 17:59:53 INFO - 'tests': ['tp5o']}, 17:59:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'tests': ['tp5o']}, 17:59:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'talos_options': ['--disable-e10s', 17:59:53 INFO - '--xperf_path', 17:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:53 INFO - 'tests': ['tp5n']}, 17:59:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:59:53 INFO - 'talos_options': ['--xperf_path', 17:59:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:59:53 INFO - 'tests': ['tp5n']}}, 17:59:53 INFO - 'talos.zip': {'path': '', 17:59:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:59:53 INFO - Running post-action listener: _resource_record_post_action 17:59:53 INFO - [mozharness: 2017-01-21 01:59:53.544511Z] Finished populate-webroot step (success) 17:59:53 INFO - [mozharness: 2017-01-21 01:59:53.544636Z] Running create-virtualenv step. 17:59:53 INFO - Running pre-action listener: _resource_record_pre_action 17:59:53 INFO - Running main action method: create_virtualenv 17:59:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:59:53 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 17:59:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:59:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:59:53 INFO - Using real prefix '/tools/python27' 17:59:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:59:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:59:57 INFO - Installing pip.................done. 17:59:57 INFO - Return code: 0 17:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:59:57 INFO - Reading from file tmpfile_stdout 17:59:57 INFO - Output received: 17:59:57 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) 17:59:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 17:59:57 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 17:59:57 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 17:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 17:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:57 INFO - 'HOME': '/Users/cltbld', 17:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PAGER': '/bin/cat', 17:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test', 17:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 17:59:57 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 17:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - 'XPC_FLAGS': '0x0', 17:59:57 INFO - 'XPC_SERVICE_NAME': '0', 17:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:57 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 17:59:57 INFO - Cleaning up... 17:59:57 INFO - Return code: 0 17:59:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:59:57 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 17:59:57 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 17:59:57 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 17:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 17:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:57 INFO - 'HOME': '/Users/cltbld', 17:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:57 INFO - 'LOGNAME': 'cltbld', 17:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:57 INFO - 'MOZ_NO_REMOTE': '1', 17:59:57 INFO - 'NO_EM_RESTART': '1', 17:59:57 INFO - 'PAGER': '/bin/cat', 17:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:57 INFO - 'PWD': '/builds/slave/test', 17:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:57 INFO - 'SHELL': '/bin/bash', 17:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 17:59:57 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 17:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:57 INFO - 'USER': 'cltbld', 17:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:57 INFO - 'XPC_FLAGS': '0x0', 17:59:57 INFO - 'XPC_SERVICE_NAME': '0', 17:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:59:58 INFO - Downloading/unpacking psutil>=3.1.1 17:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:59:58 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 17:59:58 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 17:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:01 INFO - Installing collected packages: psutil 18:00:01 INFO - Running setup.py install for psutil 18:00:01 INFO - building 'psutil._psutil_osx' extension 18:00:01 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 18:00:02 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 18:00:02 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 18:00:02 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 18:00:02 INFO - building 'psutil._psutil_posix' extension 18:00:02 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 18:00:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:00:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:00:02 INFO - ^ 18:00:02 INFO - 1 warning generated. 18:00:02 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 18:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:02 INFO - Successfully installed psutil 18:00:02 INFO - Cleaning up... 18:00:02 INFO - Return code: 0 18:00:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:02 INFO - 'HOME': '/Users/cltbld', 18:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:02 INFO - 'LOGNAME': 'cltbld', 18:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:02 INFO - 'MOZ_NO_REMOTE': '1', 18:00:02 INFO - 'NO_EM_RESTART': '1', 18:00:02 INFO - 'PAGER': '/bin/cat', 18:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:02 INFO - 'PWD': '/builds/slave/test', 18:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:02 INFO - 'SHELL': '/bin/bash', 18:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:02 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:02 INFO - 'USER': 'cltbld', 18:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:02 INFO - 'XPC_FLAGS': '0x0', 18:00:02 INFO - 'XPC_SERVICE_NAME': '0', 18:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:05 INFO - Installing collected packages: mozsystemmonitor 18:00:05 INFO - Running setup.py install for mozsystemmonitor 18:00:05 INFO - Successfully installed mozsystemmonitor 18:00:05 INFO - Cleaning up... 18:00:06 INFO - Return code: 0 18:00:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00: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==2.5.1'] in /builds/slave/test/build 18:00: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==2.5.1 18:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:06 INFO - 'HOME': '/Users/cltbld', 18:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:06 INFO - 'LOGNAME': 'cltbld', 18:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:06 INFO - 'MOZ_NO_REMOTE': '1', 18:00:06 INFO - 'NO_EM_RESTART': '1', 18:00:06 INFO - 'PAGER': '/bin/cat', 18:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:06 INFO - 'PWD': '/builds/slave/test', 18:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:06 INFO - 'SHELL': '/bin/bash', 18:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:06 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:06 INFO - 'USER': 'cltbld', 18:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:06 INFO - 'XPC_FLAGS': '0x0', 18:00:06 INFO - 'XPC_SERVICE_NAME': '0', 18:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:06 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:06 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 18:00:06 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 18:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:08 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 18:00:08 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 18:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:09 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:09 INFO - warning: no files found matching '*.txt' 18:00:09 INFO - no previously-included directories found matching 'build' 18:00:09 INFO - no previously-included directories found matching 'dist' 18:00:09 INFO - no previously-included directories found matching '.git*' 18:00:09 INFO - Installing collected packages: jsonschema, functools32 18:00:09 INFO - Running setup.py install for functools32 18:00:09 INFO - warning: no files found matching '*.txt' 18:00:09 INFO - no previously-included directories found matching 'build' 18:00:09 INFO - no previously-included directories found matching 'dist' 18:00:09 INFO - no previously-included directories found matching '.git*' 18:00:09 INFO - Successfully installed jsonschema functools32 18:00:09 INFO - Cleaning up... 18:00:09 INFO - Return code: 0 18:00:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:00:09 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')]} 18:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:09 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')]} 18:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:09 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 18:00:09 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 18:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:09 INFO - 'HOME': '/Users/cltbld', 18:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:09 INFO - 'LOGNAME': 'cltbld', 18:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:09 INFO - 'MOZ_NO_REMOTE': '1', 18:00:09 INFO - 'NO_EM_RESTART': '1', 18:00:09 INFO - 'PAGER': '/bin/cat', 18:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:09 INFO - 'PWD': '/builds/slave/test', 18:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:09 INFO - 'SHELL': '/bin/bash', 18:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:09 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:09 INFO - 'USER': 'cltbld', 18:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:09 INFO - 'XPC_FLAGS': '0x0', 18:00:09 INFO - 'XPC_SERVICE_NAME': '0', 18:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:00:09 INFO - Cleaning up... 18:00:10 INFO - Return code: 0 18:00:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:10 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:10 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 18:00:10 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 18:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:10 INFO - 'HOME': '/Users/cltbld', 18:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:10 INFO - 'LOGNAME': 'cltbld', 18:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:10 INFO - 'MOZ_NO_REMOTE': '1', 18:00:10 INFO - 'NO_EM_RESTART': '1', 18:00:10 INFO - 'PAGER': '/bin/cat', 18:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:10 INFO - 'PWD': '/builds/slave/test', 18:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:10 INFO - 'SHELL': '/bin/bash', 18:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:10 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:10 INFO - 'USER': 'cltbld', 18:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:10 INFO - 'XPC_FLAGS': '0x0', 18:00:10 INFO - 'XPC_SERVICE_NAME': '0', 18:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:10 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:10 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 18:00:10 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 18:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:12 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:12 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 18:00:12 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 18:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:13 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 18:00:13 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 18:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:14 INFO - Downloading docopt-0.6.1.tar.gz 18:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:14 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:14 INFO - Running setup.py install for blobuploader 18:00:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:14 INFO - Running setup.py install for requests 18:00:14 INFO - Running setup.py install for docopt 18:00:14 INFO - Successfully installed blobuploader requests docopt 18:00:14 INFO - Cleaning up... 18:00:15 INFO - Return code: 0 18:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:15 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')]} 18:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:15 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')]} 18:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:15 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:15 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 18:00:15 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 18:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:15 INFO - 'HOME': '/Users/cltbld', 18:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:15 INFO - 'LOGNAME': 'cltbld', 18:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:15 INFO - 'MOZ_NO_REMOTE': '1', 18:00:15 INFO - 'NO_EM_RESTART': '1', 18:00:15 INFO - 'PAGER': '/bin/cat', 18:00:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:15 INFO - 'PWD': '/builds/slave/test', 18:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:15 INFO - 'SHELL': '/bin/bash', 18:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:15 INFO - 'USER': 'cltbld', 18:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:15 INFO - 'XPC_FLAGS': '0x0', 18:00:15 INFO - 'XPC_SERVICE_NAME': '0', 18:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-TTHDuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zI52Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-BjAFS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QwA8of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-FVvhnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tU5TDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rb_G3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3n9UPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-IA6F0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-BUPmvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-a6l6YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7fQs2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-F87HNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-SAE09t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Mw47Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DUYyxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-v93KBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:17 INFO - Running setup.py install for manifestparser 18:00:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:17 INFO - Running setup.py install for mozcrash 18:00:17 INFO - Running setup.py install for mozdebug 18:00:17 INFO - Running setup.py install for mozdevice 18:00:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:17 INFO - Running setup.py install for mozfile 18:00:17 INFO - Running setup.py install for mozhttpd 18:00:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:17 INFO - Running setup.py install for mozinfo 18:00:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Running setup.py install for mozInstall 18:00:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Running setup.py install for mozleak 18:00:18 INFO - Running setup.py install for mozlog 18:00:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Running setup.py install for moznetwork 18:00:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:18 INFO - Running setup.py install for mozprocess 18:00:18 INFO - Running setup.py install for mozprofile 18:00:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:19 INFO - Running setup.py install for mozrunner 18:00:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:19 INFO - Running setup.py install for mozscreenshot 18:00:19 INFO - Running setup.py install for moztest 18:00:19 INFO - Running setup.py install for mozversion 18:00:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:19 INFO - Cleaning up... 18:00:19 INFO - Return code: 0 18:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:19 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')]} 18:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:19 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')]} 18:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:19 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:19 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 18:00:19 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 18:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:19 INFO - 'HOME': '/Users/cltbld', 18:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:19 INFO - 'LOGNAME': 'cltbld', 18:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:19 INFO - 'MOZ_NO_REMOTE': '1', 18:00:19 INFO - 'NO_EM_RESTART': '1', 18:00:19 INFO - 'PAGER': '/bin/cat', 18:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:19 INFO - 'PWD': '/builds/slave/test', 18:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:19 INFO - 'SHELL': '/bin/bash', 18:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:19 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:19 INFO - 'USER': 'cltbld', 18:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:19 INFO - 'XPC_FLAGS': '0x0', 18:00:19 INFO - 'XPC_SERVICE_NAME': '0', 18:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:19 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6689Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6lfbyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-uy58ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6jhkIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-znZavT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-nWs8qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iMBgNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:20 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)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7hZz4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:20 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)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dBSdGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zl6f_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:20 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)) 18:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:20 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dUhqBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KNqzKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JOHvrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qg4B50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-OEL9YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Bw1H4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:21 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-fn9mvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:00:21 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:21 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:00:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:21 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 18:00:21 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 18:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:24 INFO - Downloading blessings-1.6.tar.gz 18:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:24 INFO - Installing collected packages: blessings 18:00:24 INFO - Running setup.py install for blessings 18:00:24 INFO - Successfully installed blessings 18:00:24 INFO - Cleaning up... 18:00:24 INFO - Return code: 0 18:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:25 INFO - Reading from file tmpfile_stdout 18:00:25 INFO - Current package versions: 18:00:25 INFO - blessings == 1.6 18:00:25 INFO - blobuploader == 1.2.4 18:00:25 INFO - docopt == 0.6.1 18:00:25 INFO - functools32 == 3.2.3-2 18:00:25 INFO - jsonschema == 2.5.1 18:00:25 INFO - manifestparser == 1.1 18:00:25 INFO - mozInstall == 1.12 18:00:25 INFO - mozcrash == 1.0 18:00:25 INFO - mozdebug == 0.1 18:00:25 INFO - mozdevice == 0.48 18:00:25 INFO - mozfile == 1.2 18:00:25 INFO - mozhttpd == 0.7 18:00:25 INFO - mozinfo == 0.9 18:00:25 INFO - mozleak == 0.1 18:00:25 INFO - mozlog == 3.4 18:00:25 INFO - moznetwork == 0.27 18:00:25 INFO - mozprocess == 0.23 18:00:25 INFO - mozprofile == 0.28 18:00:25 INFO - mozrunner == 6.13 18:00:25 INFO - mozscreenshot == 0.1 18:00:25 INFO - mozsystemmonitor == 0.3 18:00:25 INFO - moztest == 0.8 18:00:25 INFO - mozversion == 1.4 18:00:25 INFO - psutil == 3.1.1 18:00:25 INFO - requests == 1.2.3 18:00:25 INFO - wsgiref == 0.1.2 18:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:25 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')]} 18:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:25 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')]} 18:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:26 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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:26 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 18:00:26 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 18:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:26 INFO - 'HOME': '/Users/cltbld', 18:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:26 INFO - 'LOGNAME': 'cltbld', 18:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:26 INFO - 'MOZ_NO_REMOTE': '1', 18:00:26 INFO - 'NO_EM_RESTART': '1', 18:00:26 INFO - 'PAGER': '/bin/cat', 18:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:26 INFO - 'PWD': '/builds/slave/test', 18:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:26 INFO - 'SHELL': '/bin/bash', 18:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:26 INFO - 'USER': 'cltbld', 18:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:26 INFO - 'XPC_FLAGS': '0x0', 18:00:26 INFO - 'XPC_SERVICE_NAME': '0', 18:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:00:26 INFO - Cleaning up... 18:00:26 INFO - Return code: 0 18:00:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:26 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')]} 18:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:26 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')]} 18:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10ee8a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee00570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b82db0c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, '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.SWNDhYMgKn/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.mXyb0naROR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 18:00:26 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 18:00:26 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 18:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:26 INFO - 'HOME': '/Users/cltbld', 18:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:26 INFO - 'LOGNAME': 'cltbld', 18:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:26 INFO - 'MOZ_NO_REMOTE': '1', 18:00:26 INFO - 'NO_EM_RESTART': '1', 18:00:26 INFO - 'PAGER': '/bin/cat', 18:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:26 INFO - 'PWD': '/builds/slave/test', 18:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:26 INFO - 'SHELL': '/bin/bash', 18:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:00:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:26 INFO - 'USER': 'cltbld', 18:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:26 INFO - 'XPC_FLAGS': '0x0', 18:00:26 INFO - 'XPC_SERVICE_NAME': '0', 18:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:26 INFO - Cleaning up... 18:00:26 INFO - Return code: 0 18:00:26 INFO - Running post-action listener: _resource_record_post_action 18:00:26 INFO - Running post-action listener: _start_resource_monitoring 18:00:26 INFO - Starting resource monitoring. 18:00:26 INFO - [mozharness: 2017-01-21 02:00:26.990456Z] Finished create-virtualenv step (success) 18:00:26 INFO - [mozharness: 2017-01-21 02:00:26.991422Z] Running install step. 18:00:26 INFO - Running pre-action listener: _resource_record_pre_action 18:00:26 INFO - Running main action method: install 18:00:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:27 INFO - Reading from file tmpfile_stdout 18:00:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:27 INFO - Reading from file tmpfile_stdout 18:00:27 INFO - Output received: 18:00:27 INFO - Usage: mozinstall [options] installer 18:00:27 INFO - Options: 18:00:27 INFO - -h, --help show this help message and exit 18:00:27 INFO - -d DEST, --destination=DEST 18:00:27 INFO - Directory to install application into. [default: 18:00:27 INFO - "/builds/slave/test"] 18:00:27 INFO - --app=APP Application being installed. [default: firefox] 18:00:27 INFO - mkdir: /builds/slave/test/build/application 18:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:00:59 INFO - Reading from file tmpfile_stdout 18:00:59 INFO - Output received: 18:00:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:00:59 INFO - Running post-action listener: _resource_record_post_action 18:00:59 INFO - [mozharness: 2017-01-21 02:00:59.911075Z] Finished install step (success) 18:00:59 INFO - [mozharness: 2017-01-21 02:00:59.911221Z] Running run-tests step. 18:00:59 INFO - Running pre-action listener: _resource_record_pre_action 18:00:59 INFO - Running main action method: run_tests 18:00:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:00:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:00:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:00:59 INFO - 2017-01-20 18:00:59.925 screenresolution[1617:7635] starting screenresolution argv=screenresolution get 18:00:59 INFO - 2017-01-20 18:00:59.928 screenresolution[1617:7635] Display 0: 1600x1200x32@60 18:00:59 INFO - 2017-01-20 18:00:59.934 screenresolution[1618:7638] starting screenresolution argv=screenresolution list 18:00:59 INFO - Available Modes on Display 0 18:00:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:00:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:00:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:00:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:01:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:01:00 INFO - Intel Iris: 18:01:00 INFO - Chipset Model: Intel Iris 18:01:00 INFO - Type: GPU 18:01:00 INFO - Bus: Built-In 18:01:00 INFO - VRAM (Dynamic, Max): 1536 MB 18:01:00 INFO - Vendor: Intel (0x8086) 18:01:00 INFO - Device ID: 0x0a2e 18:01:00 INFO - Revision ID: 0x0009 18:01:00 INFO - Displays: 18:01:00 INFO - Display: 18:01:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:01:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:01:00 INFO - Display Serial Number: 1600x1200 60 18:01:00 INFO - Main Display: Yes 18:01:00 INFO - Mirror: Off 18:01:00 INFO - Online: Yes 18:01:00 INFO - Rotation: Supported 18:01:00 INFO - Return code: 0 18:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:00 INFO - Python 2.7.3 18:01:00 INFO - Return code: 0 18:01:00 INFO - grabbing minidump binary from tooltool 18:01: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')]} 18:01:00 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 0x10ec9ed30>, '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 0x10eb04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec96b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:00 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 18:01:00 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 18:01:00 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 18:01:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:00 INFO - Return code: 0 18:01:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:01:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:01:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 18:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 18:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWNDhYMgKn/Render', 18:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:00 INFO - 'HOME': '/Users/cltbld', 18:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:00 INFO - 'LOGNAME': 'cltbld', 18:01:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:00 INFO - 'MOZ_NO_REMOTE': '1', 18:01:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:00 INFO - 'NO_EM_RESTART': '1', 18:01:00 INFO - 'PAGER': '/bin/cat', 18:01:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:00 INFO - 'PWD': '/builds/slave/test', 18:01:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:00 INFO - 'SHELL': '/bin/bash', 18:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXyb0naROR/Listeners', 18:01:00 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 18:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:00 INFO - 'USER': 'cltbld', 18:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:00 INFO - 'XPC_FLAGS': '0x0', 18:01:00 INFO - 'XPC_SERVICE_NAME': '0', 18:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 18:01:00 INFO - mozversion application_buildid: 20170120154124 18:01:00 INFO - mozversion application_changeset: b9613014ba65c40a78227be03c69e993c70f96ad 18:01:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:01:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:00 INFO - mozversion application_name: Firefox 18:01:00 INFO - mozversion application_remotingname: firefox-dev 18:01:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:00 INFO - mozversion application_vendor: Mozilla 18:01:00 INFO - mozversion application_version: 52.0a2 18:01:00 INFO - mozversion platform_buildid: 20170120154124 18:01:00 INFO - mozversion platform_changeset: b9613014ba65c40a78227be03c69e993c70f96ad 18:01:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:00 INFO - mozversion platform_version: 52.0a2 18:01:00 INFO - using testdate: 1484964060 18:01:00 INFO - actual date: 1484964060 18:01:00 INFO - starting webserver on 'localhost:49239' 18:01:00 INFO - SUITE-START | Running 2 tests 18:01:00 INFO - TEST-START | dromaeo_css 18:01:00 INFO - operating with platform_type : mac_ 18:01:00 INFO - Initialising browser for dromaeo_css test... 18:01:00 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmppP5trU/profile http://localhost:49239/getInfo.html) 18:01:03 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 18:01:03 INFO - PROCESS | 1628 | colorDepth:24 18:01:03 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 18:01:03 INFO - PROCESS | 1628 | __metrics 18:01:03 INFO - PROCESS | 1628 | 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" 18:01:03 INFO - PROCESS | 1628 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:01:04 INFO - TEST-INFO | 1628: exit 0 18:01:04 INFO - Browser initialized. 18:01:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:04 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmppP5trU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:16 INFO - PROCESS | 1630 | RSS: Main: 222130176 18:01:16 INFO - PROCESS | 1630 | 18:04:20 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 18:04:22 INFO - PROCESS | 1630 | RSS: Main: 374865920 18:04:22 INFO - PROCESS | 1630 | 18:07:25 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 18:07:25 INFO - PROCESS | 1630 | RSS: Main: 350830592 18:07:25 INFO - PROCESS | 1630 | 18:10:28 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 18:10:28 INFO - PROCESS | 1630 | RSS: Main: 322662400 18:10:28 INFO - PROCESS | 1630 | 18:13:31 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 18:13:31 INFO - PROCESS | 1630 | RSS: Main: 329891840 18:13:31 INFO - PROCESS | 1630 | 18:16:35 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 18:16:35 INFO - PROCESS | 1630 | RSS: Main: 306192384 18:16:35 INFO - PROCESS | 1630 | 18:19:38 INFO - PROCESS | 1630 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 18:19:39 INFO - PROCESS | 1630 | RSS: Main: 407248896 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | __start_tp_report 18:19:39 INFO - PROCESS | 1630 | _x_x_mozilla_page_load 18:19:39 INFO - PROCESS | 1630 | _x_x_mozilla_page_load_details 18:19:39 INFO - PROCESS | 1630 | |i|pagename|runs| 18:19:39 INFO - PROCESS | 1630 | |0;dojo.html;3299.1422230220137;3310.9834450827743;3315.0717799016275;3339.7662163648524;3367;4790.496997815231;5637.943620563793;5676.403977582357;5687.459691329317;5731.1689804978305;5655.604107712462;5659.632123911953;5704.030314846475;5731.312242530902;5798.304203495586;5179.741012949356;5180.6891586504935;5194.63637545372;5247.265382846385;5267.578593712494;5156.252343410203;5164.561012313958;5185.092608793446;5219.243209734586;5339.492748188935;5248.134057880445;5307.363116426015;5320.813771517997;5326.733663316838;5352.518273355417;5301.522862942315;5308.150695888678;5308.92036619451;5312.654677445992;5363.249145119687;4990.750462476862;5124.4106927703415;5232.9738351308;5239.056969745444;5251.133562962144;5647.717614119319;5648.096304591246;5686.2039314496005;5772.2496075510335;5774.105013722879;5265.552428043583;6180.2892667343385;6216.409441103088;6256.843578910563;6275.121482992385;6265.467435268008;6274.686265686697;6276.964300890348;6279.183706118175;6312.968435157841;5642.181883626892;5651.095824668075;5718.999175144333;5782.479576838021;5861.120831875252;6212.960336771669;6223.844403889939;6236.158118654014;6244.438000579969;6251.12484252205;6119.479844213202;6144.631322120687;6151.231096112986;6164.5684802064325;6170.568060235741;6102.284011916584;6168.167297414791;6196.039613859859;6256.562040657111;6257.749690012349;6258.217722784652;6262.279837818709;6271.996480563088;6273.059041143773;6274.968625156845;6207.472364848948;6224.066390041439;6252.374762523711;6286.402791734778;6286.5599408041;4827.565519103227;4874;4879.487653796371;4906.975465122651;5002.97439024999;4420.292753159479;4444.444444444444;4451.710638808467;4467.463904331436;4505.594496495331;5743.511801496919;5777.306723193244;5786.291124637013;5788.305403351625;5824.621399609012;6100.633961962297;6106.664133472702;6287.2140982377205;6306.936930630727;6311.905321420182;5668.886622267614;5670.121131224667;5689.630174038674;5705.887351966409;5753.079507278815;5376.838694839161;5423;5427.0773968425465;5434.70109143993;5447;6268.623882567061;6274.6548939808745;6282.340354262737;6289.150964619717;6310.337414571404;5967.194428752063;6103.6032657877095;6111.052786818051;6212.378762123752;6297.244330680164;6250.156228909039;6270.216222972129;6274.341194174546;6288.213973253343;6291.02489114188;6170.352113028068;6212.161358216764;6233.501319894488;6234.127222188807;6235.594686345373;5650.886982260414;6040.731446396306;6127.509799215963;6143.358355907003;6212.161358216764;5121.206213036985;6033.78881739137;6059.939400606114;6088.208532890873;6132.355508992456;5942.197803296673;6029.155918171372;6084.482818960261;6092.208012958287;6125.693715314305;5859.531237501075;5885.735141918538;5897.498712609477;5933.110033495011;5936.257967754031;4993.375828021497;5923;5956;5978.252718410199;5980;5882.794102206402;5896.8820623586425;5897.823065308047;5900.085486749561;5932.139839723302 18:19:39 INFO - PROCESS | 1630 | |1;ext.html;460.89860230749264;471.73111326543886;477.23642172523955;490.374772165489;520.778669065647;29127.854360728194;30682.84658576704;30684.84657576709;30688.84655576719;30716.53925191121;31516.842415787945;31803;31948;39836.60163398365;40424.79787601065;8700.477971321741;8913.841200643907;9215.354925155241;9367.81264374712;9382.85925711115;9206.539673016356;9308.441493510378;9314.86027709585;9317.906820931805;9328.48693321867;8373.07896131428;8591.656333746643;9298.20965217954;10947.34315941042;11296.491657875415;11122.666320010412;11207.159463040223;11223.775524489505;11236.943815280953;11241.831372529337;8311.459755115899;11128.554857805759;11191.2725672831;11195.440227988567;11212.607558735486;29383.853080734672;37606.811965940266;38120.80939595312;38197;39577.60422395768;3196.4246435641576;3279.5244689519886;3303.96696033039;3436.244026314207;3841.135744457503;27149.06829197681;27734.8906043758;28715.425691486264;28761.56857647137;29812.701872981208;3111.828849413281;3175.6348019977536;3179.984100079508;3226.677332266778;3231.1922019495128;500143;501533;503933;504939;513133;48118;49393.50606493961;53701.462985370425;56452;56963.430365696644;56623.433765661815;59458.70270648619;59475;59483.405165947785;59520;15331.463398780988;15443.459478918185;15468.767968480483;15473.767893481607;15475.535733928;11910.106741994385;11988.460519276654;12000.519979200733;12005.819912701316;12030.157888947864;13536.932315338558;15324.846751532565;15330.693386132214;15423.074615523105;15440.382384704712;5040.873978150576;5210.140326846104;6021;6123.877522449526;6456.967715161394;852.8933883264592;877.731677725693;924.8795574852803;1022.8414595737672;1059.885528370905;27002.53895554323;28324;28569.857150714113;28945.565816512768;29028.709712903023;853.3685073045901;1066.4294602387686;1106.2975010868156;1113.9554417823358;1181.5628217559558;14416.351264193136;14782.630434239016;14913.478028268959;15214.16322102295;15360.385584576716;644779;646670.7666461638;647367;648011;650450;46145.76927115343;54667.45332546703;54708.72645636746;54964.72517637386;55031.44968550343;1329.2821876186945;1353.4383230959043;1385.2865774126333;1385.5773988933472;1386.209860379574;27549;27585.724142758314;27892.02377916763;28623;28660.85669571639;41173;46966.29550556813;47125.764371177924;47198.05603887972;47240.055198896516;590721;591152;592229;592563;592648;25141.120060797784;25259.74740252574;25421;25425.61861572041;25450.618240726035;43454.34818477662;43723.781381094166;43946.34080488731;44826.77586612046;45113.77443112763;32513.374331283816;36169.0957726059;36847.973361465374;36860;37302.8134859324;35762;36822.44766328561;36963;37068.25863482661;37696.43455348117;36308.63691363052;37046.629533705396;37072.88781336564;37686.62313376941;38289.80855095707;25037;28278.85860570684;30662;32982.670173297956;33000.66999329976;20568.177272908917;21289.68065478988;24709;24801.25596232116;24985.000599975796 18:19:39 INFO - PROCESS | 1630 | |2;jquery.html;331.93029463812604;336.50365710576887;352.4378616107311;380.6612115217457;400.8116185392866;14402.855971440282;14586.92706536467;15384.538463846075;16446.588835279123;19873.900630496864;18921.526961825963;19462.513437164078;20536.38390848277;20546.69179962302;20634.89682551585;5702.914456283149;5887.322957859837;5903.793367232148;5907;6033.728482218311;4987.576056035241;5929.584929054968;6000.819975400745;6061.45446909778;6066.726997285133;6012.969935150318;6015.639061656293;6016.699165041752;6019.909701354483;6023.789167379143;5682.602217844753;5951.434613711691;5969.462748352669;5983.820485385445;5984.73068711909;5072.746362681851;5199.324087868591;5218.504242096995;5222.660527065728;5228.843134705965;12515.186512876633;13215.66960825987;13224.14043087206;13226.272555009471;13809.654758631115;2151.5159089204803;2215.3464727905143;2217.2904670505445;2269.795718385337;2296.1619009061737;9217.677381291622;9636;9888.802223955552;10188.490575471196;10206.489675516195;1645.465223802257;1738.774164214226;1791.3730194431976;1814.528222662104;1837.5865430278213;102622;104502;109649.93850676419;111041.99999999919;111654;11283.717907052225;11375.033122184706;11574;11580.76838463226;11736.94131529354;14347.56957291283;14549.254089509326;14549.490767823076;14568.05307654999;14601.342939567745;7183.964080179566;8232.259096681328;8284.751457456287;8360.874586881202;8373.748787536384;8144.30773384269;8192.426530142951;8340.541270230196;8341.541215233221;8354.122817104238;4431.578999994996;4494.303382975644;4505.211587972158;4529.275315949432;4590.678652494294;1632.4939268826465;1841.5672317005492;1878.7369768232459;1894.602133551942;1905.8856468611928;365.6508034826734;382.14590390477815;398.7846562856025;423.1917038456533;793.4604468961046;11479.081673466102;11517.884821151682;11604.071674266039;11783.823242651368;12041.698957525956;415.5553557693239;418.94553708017764;429.9161663475592;441.69523029109814;442.16210281516345;5994.67029313392;6004.249468816398;6039.275286965504;6068.848278793065;6174.598651087665;591400;602583;606760;609096;612239;125732.37133814272;128381;133550.33224834007;134078.65921340857;135712.32143839414;428.8777698356016;436.1625678696846;436.6681322195091;441.86964845370693;443.08945117783264;10967.287126336763;11011.064059555027;11034.282771619819;11054;11064.446777661246;44646.3303050448;46101.07797843957;46579;51656;54176.458235418715;66442.33557664555;67400.2929838844;68072.3192768066;68312.6584367075;68840;5604.607677462538;7340.788769852915;7842.568658723597;8129.390295727962;8366.748997530083;11750.294982300748;12383.690407739517;12467.93766031164;12967.157134786208;13040;10692.14462842955;10752.946235268773;10818.459077045958;11122.44387780624;11166.832497512381;9580.66467673628;10797.838032429363;10871.728206794893;11136.443177841238;11211.831822522832;10082.949585252027;10971.83542246851;11213.15901307389;11407.657770266906;11444.141689373497;7976.401769867167;7997.720079797179;8037.7588672339925;8056.274935255855;8095.83808323842;9851.359661621971;10636.149108071491;10763.354198747787;10913.18151138652;11124.499397527292 18:19:39 INFO - PROCESS | 1630 | |3;mootools.html;1281.1096288079789;1363.1480324797;1483.0212060040371;1652.6612044530873;1873.2132504348172;7475.813104672379;7844.372450203984;8172.1827817218245;8438.957805210965;8451.957740211306;8271.048829384623;8374.288185504225;8381.832363352745;8384.496930184194;8390.202930721573;2295.6671282664006;2341.3327201747506;2343.121329501437;2344.824138189643;2347.108098922407;2052.702358158066;2310.572544079342;2361.1853910400882;2375.6911601491784;2382.761723827612;2303.6429353450158;2310.722713274409;2334.5214231082587;2337.1118974789556;2341.426350544119;2246.8202543796456;2283.178055899875;2314.0743702518957;2315.5368926214824;2316.397736588482;1921.875702713914;2158.6222411077997;2187.5187458759046;2188.321620297713;2188.89055547222;8034.558099304536;8192.18078192182;8199.467034642788;8391.160883911622;8409.159084091603;4754.643401744883;5269.367675878919;5274.129768588178;5274.498922602346;5282.524572788468;3136.4197623439736;3249.886253981123;3546.202104526487;3616.3490571697084;3628.274345130958;1068.4444089073716;1084.728817795551;1100.5597760895625;1101.9889801101967;1106.673531308266;10936.179786516042;10951.616693415692;11023.228374013823;11032.172587056002;11044;4323.156984388014;4353.085851971058;4493.1013797240685;4508.954910450919;4529.773511324421;8693;8714.607842647096;8740.388172827841;8748.47509149453;8753;5103.897922041612;5106.361704786902;5108.821191258288;5115.56517696;5116.104681680691;4242.024334403043;4384.079343337935;4466.888327791831;4676.906461870812;4739.336492890998;3629.9092522686615;3658.689011434005;3716.0524066362905;3758.1732018955786;3765.585785563586;1144.9313041217554;1154.6478324111226;1154.8787377325427;1163.4299193395175;1164.4061528620464;791.7308115240846;806.3871457692196;814.767791179511;819.9262066414051;888.1606881496923;5368.624196306221;5556.249906262603;5574.275344205227;5825.126231065289;5971.611845230046;849.1126772522605;894.2577660541734;907.5144797533288;909.8225845960106;916.8166366726681;3345.882894098695;3714.5542534895985;3754.718396120302;3824.2351529694174;3851.7496362736333;9939.50302484873;10243;10352.430616316175;10358.274920755626;10362;8274.875876861852;10152.695419137437;10195.898041019494;10322.277440579088;10323.587056517656;7807.804804879924;7890.368770498347;8002.519848809206;8013.439059265912;8028.197180282042;4908.631852610997;5410.296661433988;5487.560995120461;5711.942880571141;5716.79991200306;9295.442273463614;9314.580843861906;9350.064993500595;9475.431474111576;9534.046595340411;9450.858237126311;9583.904160958302;9591.040895910353;9702.417854928726;9717.6598819041;6253.5622506424115;6353.491720662243;6816.829579260559;6833.555818871758;6948.131483564554;8058.274755272054;8146.674133034612;8146.837063258583;8157.469764465291;8162.347012239125;6394.840128996812;7118.928810711826;7201.099862517185;7230.89153662706;7280.235575264521;6919.308069193041;7132.750353737594;7157.821054473679;7179.317964793337;7284.125904891447;6706.798796036127;6764.323567643393;6786.355296246848;6836.213835408992;6885.862282754217;4872.098661747588;4904.5340692634145;4904.534069263557;4936.136176169084;4954.9752251238515;4827.131116399082;4882.755862206946;4890.070886531547;4983.103041452428;5003.124453220599 18:19:39 INFO - PROCESS | 1630 | |4;prototype.html;291.50444244783876;298.34959787662893;305.79817320568424;309.84972288440116;311.68364110427905;4432.764082219981;4705.3766450574585;5042.0168067226905;5057;5141.537261646451;3861.7876016819064;4215.789210539476;4330.3504474328865;4422.4963512405775;5047.798088076473;3136.8588413521447;3333.1500467380783;3630.963690363089;3963.7621742695387;3990.0024993751563;3810.8856734298015;3974.052714170065;3976.880693579197;4001.159756451149;4005.2390045891334;3458.291050334675;3600.261946301002;3931.292367373886;3938.8818335449982;3962.881113566598;3898.785566793825;3908.511436070491;3928.7839168845703;3943.211357728437;3950.5456872459604;3145.811251324928;3187.2509960159346;3428.5200071989943;3446.9827650861585;3454.8790792322147;4715.386999690053;4733.633183408296;4996.675216110941;4997.950430409618;5014.874628134289;4112.465379500646;4470.798814053375;4492.258777301741;4512.052468981517;4519.2091384008;4521.434820647419;4976.402831660224;5290.365156181244;5377;5466.426025267329;3160.4153231652217;3449.5515582974303;3752.212035472554;3753.193063491335;3779.433085037266;4719.740414277179;5331.546818520431;5655.802046928337;5681.857953551194;5686.857828554319;3756.3096606527174;3787.5265591801026;3809.3333666608232;3812.4853144825092;3826.4069069293746;3875.9031024224055;3882.902927426837;3893.785841778673;3894.727369084137;3900.473436086149;4077.734947228421;4129.112240868228;4140.701910439675;4156.8129434175535;4424.80088396023;5366.731663416892;5389.8113566025;5411.538884501163;5418.103663717668;5419.430959749248;1169.5672601137633;1182.2079206931376;1222.3986577583394;1239.9938000309942;1243.3348158735034;788.8895554622358;796.3748457460865;808.2604416958417;810.801353668355;828.8632375657949;4742.264948932921;4742.952570474251;4769.928451073237;4777.904441911142;4838.854834354975;4521.706089104197;4582.450105987303;4854.393200849894;5060.51925067118;5247.16045432729;4488.551144885485;4688.179134005774;4887.853364399074;5234.712090834964;5280.6467892888295;2582.6384306197147;2781.2629653141935;2812.6343575335077;2824.943501129966;2825.321922738569;4796;5199.428062913076;5451.536619387396;5473.808416705396;5514.944850551524;4817.614590832725;5122.106010104354;5336;5395.379531353866;5450.683459529684;5033.439633713488;5383.730813459311;5452;5464.513646290928;5470.261514695545;4552.884543286916;5098.923516147335;5118.539331460186;5166.948330516797;5305.336832895888;4612.630989520763;4854.708717476963;4975.353204083591;5276.868078298074;5284.841454756363;4856.368672072608;5115.948840511547;5391.29913111293;5443.673379597237;5446;3222.564953731216;3510.9473357900165;3591.946120808242;3601.459781032866;3627.4558816176727;4688.484266730588;4905.302083853795;4935.62982776286;5612.607117501736;5672.205891175321;4752.904941901212;5310.6813591184655;5450.5367043801725;5481.3141560635795;5485.6982865942755;4553.2259515881715;4771.332013518179;4876.341693871282;5318.73953569739;5391.919121213264;5090.2364645303505;5273.393559740679;5332.214127969185;5345.839624811262;5347.545458636059;5302.734863256745;5332.893342133058;5494.697791621499;5506.91739623914;5512.862178445571;4772.594329481894;4958.743771583849;5324.6006549508165;5410.185818997518;5430.67415955044 18:19:39 INFO - PROCESS | 1630 | |5;yui.html;602.8837444129308;691.084313284897;694.5416025423218;727.0802434919827;760.5769278443543;13894.444222231112;14207.218602976858;14283.928580357097;14474.782878256821;14571.27143642819;12838.614841554745;13124.212547247173;13137.080404371698;13145.67135821605;13157.67105822355;793.7420338390017;804.0672819529333;817.6198067898426;818.643889907889;819.2790344496834;801.831615360772;817.5176645778989;818.3780326951501;818.3862103422433;818.7380038387719;872.4939535069644;872.8821609082756;873.1835733589114;873.5544872115236;873.6330741088758;866.7659731872359;866.9089745576719;867.176182626501;868.2402897464718;868.3053557154283;640.4012248547576;640.5676168586185;641.977530786425;642.1331202876127;642.3127253838395;13429.529966451226;14320.212388318638;14447.494337698236;14453.78319325211;14454.421823127062;12617.242965422103;12959.740805183843;13007.804882926765;13014.284214368206;13022.999999999905;9573.234141268751;9956.95021524895;9958.302918795687;10047;10056.547455364453;3489.2498112905846;3577.463380492921;3632.5640923089136;3686.3548878946344;3773.716971227169;83532;88656;88860.55569722175;89131.10868891294;89872.55063724706;10025.19798416125;10127.037931396506;10216.693499195037;10262.332948358333;10447.268691191544;19390.903045484964;20182.697259541117;20209.292674756314;20359.08384122718;20410.285640002825;7404.666789994463;7455.291747283999;7506.62466876654;7564.167941526428;7739;4034.9798251008556;4094.9795251023556;4129.15352352767;4382.6055654991205;4393.450818647669;3087.336222712128;3398.813065281384;3402.8128452935325;3516.1912760064815;3522;626.6490765171518;632.4845251120322;632.9556931014785;638.4541217259269;651.6383407209045;555.5833125156133;562.8142712904731;601.8344955137372;648.4229036157823;658.9077529145924;8451.830963380698;8781.560921953876;8784.429012114193;8876.112388761072;9017;532.51541097601;613;641.4996302883758;658.769430699261;674.8211723893172;3734.8879533614036;3902.375619900859;4001.2197621463533;4158.438610787565;4189.413482112506;104335;109271;113351;114039.42980285212;117550.4122479382;58789;72724.63637681778;90846;98763.50618246863;102614.48692756638;88295;88336;90679;91145.1770964577;91621.54189229012;8841.970952082043;9228.815423691623;9284.535773211448;9533.952330238304;9731.513424328614;38324;38409.807950960065;51350.97298054093;52815.207771882684;54222;70347.6870816249;76097.6195119043;78598;80770.59614701889;80912;11699.824502632637;11811.93692567673;12066.215695979734;12090.274583525017;12236.510539578318;11531.596394126502;13977.510787122403;14143.222122783345;14206.644833879236;14577.562673119823;10839;12554.435050422935;12616.990640748902;13050;13616.38726257301;12697.873021269668;12957.870421295667;13049.151805133015;13084.28036458004;13651.522196723066;12252.326122063372;12369.257844529357;12388.256704597752;12409.813852792035;12475.875241247471;10361.63734269297;10887.510062047386;11031.39327336972;11055.502502387573;11419.60031398897;10892.836607451052;11114.777704446027;11142.777144457228;11308.49111789955;11353.48909299067 18:19:39 INFO - PROCESS | 1630 | __end_tp_report 18:19:39 INFO - PROCESS | 1630 | __start_cc_report 18:19:39 INFO - PROCESS | 1630 | _x_x_mozilla_cycle_collect,1866 18:19:39 INFO - PROCESS | 1630 | __end_cc_report 18:19:39 INFO - PROCESS | 1630 | __startTimestamp1484965179000__endTimestamp 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | ------- Summary: start ------- 18:19:39 INFO - PROCESS | 1630 | Number of tests: 6 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#0] dojo.html Cycles:165 Average:5714.15 Median:5896.88 stddev:635.71 (10.8%) stddev-sans-first:608.77 18:19:39 INFO - PROCESS | 1630 | Values: 3299.1 3311.0 3315.1 3339.8 3367.0 4790.5 5637.9 5676.4 5687.5 5731.2 5655.6 5659.6 5704.0 5731.3 5798.3 5179.7 5180.7 5194.6 5247.3 5267.6 5156.3 5164.6 5185.1 5219.2 5339.5 5248.1 5307.4 5320.8 5326.7 5352.5 5301.5 5308.2 5308.9 5312.7 5363.2 4990.8 5124.4 5233.0 5239.1 5251.1 5647.7 5648.1 5686.2 5772.2 5774.1 5265.6 6180.3 6216.4 6256.8 6275.1 6265.5 6274.7 6277.0 6279.2 6313.0 5642.2 5651.1 5719.0 5782.5 5861.1 6213.0 6223.8 6236.2 6244.4 6251.1 6119.5 6144.6 6151.2 6164.6 6170.6 6102.3 6168.2 6196.0 6256.6 6257.7 6258.2 6262.3 6272.0 6273.1 6275.0 6207.5 6224.1 6252.4 6286.4 6286.6 4827.6 4874.0 4879.5 4907.0 5003.0 4420.3 4444.4 4451.7 4467.5 4505.6 5743.5 5777.3 5786.3 5788.3 5824.6 6100.6 6106.7 6287.2 6306.9 6311.9 5668.9 5670.1 5689.6 5705.9 5753.1 5376.8 5423.0 5427.1 5434.7 5447.0 6268.6 6274.7 6282.3 6289.2 6310.3 5967.2 6103.6 6111.1 6212.4 6297.2 6250.2 6270.2 6274.3 6288.2 6291.0 6170.4 6212.2 6233.5 6234.1 6235.6 5650.9 6040.7 6127.5 6143.4 6212.2 5121.2 6033.8 6059.9 6088.2 6132.4 5942.2 6029.2 6084.5 6092.2 6125.7 5859.5 5885.7 5897.5 5933.1 5936.3 4993.4 5923.0 5956.0 5978.3 5980.0 5882.8 5896.9 5897.8 5900.1 5932.1 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#1] ext.html Cycles:180 Average:69397.24 Median:19599.12 stddev:156565.79 (798.8%) stddev-sans-first:156919.44 18:19:39 INFO - PROCESS | 1630 | Values: 460.9 471.7 477.2 490.4 520.8 29127.9 30682.8 30684.8 30688.8 30716.5 31516.8 31803.0 31948.0 39836.6 40424.8 8700.5 8913.8 9215.4 9367.8 9382.9 9206.5 9308.4 9314.9 9317.9 9328.5 8373.1 8591.7 9298.2 10947.3 11296.5 11122.7 11207.2 11223.8 11236.9 11241.8 8311.5 11128.6 11191.3 11195.4 11212.6 29383.9 37606.8 38120.8 38197.0 39577.6 3196.4 3279.5 3304.0 3436.2 3841.1 27149.1 27734.9 28715.4 28761.6 29812.7 3111.8 3175.6 3180.0 3226.7 3231.2 500143.0 501533.0 503933.0 504939.0 513133.0 48118.0 49393.5 53701.5 56452.0 56963.4 56623.4 59458.7 59475.0 59483.4 59520.0 15331.5 15443.5 15468.8 15473.8 15475.5 11910.1 11988.5 12000.5 12005.8 12030.2 13536.9 15324.8 15330.7 15423.1 15440.4 5040.9 5210.1 6021.0 6123.9 6457.0 852.9 877.7 924.9 1022.8 1059.9 27002.5 28324.0 28569.9 28945.6 29028.7 853.4 1066.4 1106.3 1114.0 1181.6 14416.4 14782.6 14913.5 15214.2 15360.4 644779.0 646670.8 647367.0 648011.0 650450.0 46145.8 54667.5 54708.7 54964.7 55031.4 1329.3 1353.4 1385.3 1385.6 1386.2 27549.0 27585.7 27892.0 28623.0 28660.9 41173.0 46966.3 47125.8 47198.1 47240.1 590721.0 591152.0 592229.0 592563.0 592648.0 25141.1 25259.7 25421.0 25425.6 25450.6 43454.3 43723.8 43946.3 44826.8 45113.8 32513.4 36169.1 36848.0 36860.0 37302.8 35762.0 36822.4 36963.0 37068.3 37696.4 36308.6 37046.6 37072.9 37686.6 38289.8 25037.0 28278.9 30662.0 32982.7 33000.7 20568.2 21289.7 24709.0 24801.3 24985.0 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#2] jquery.html Cycles:180 Average:33410.29 Median:390.47 stddev:100803.80 (25816.3%) stddev-sans-first:101055.99 18:19:39 INFO - PROCESS | 1630 | Values: 331.9 336.5 352.4 380.7 400.8 14402.9 14586.9 15384.5 16446.6 19873.9 18921.5 19462.5 20536.4 20546.7 20634.9 5702.9 5887.3 5903.8 5907.0 6033.7 4987.6 5929.6 6000.8 6061.5 6066.7 6013.0 6015.6 6016.7 6019.9 6023.8 5682.6 5951.4 5969.5 5983.8 5984.7 5072.7 5199.3 5218.5 5222.7 5228.8 12515.2 13215.7 13224.1 13226.3 13809.7 2151.5 2215.3 2217.3 2269.8 2296.2 9217.7 9636.0 9888.8 10188.5 10206.5 1645.5 1738.8 1791.4 1814.5 1837.6 102622.0 104502.0 109649.9 111042.0 111654.0 11283.7 11375.0 11574.0 11580.8 11736.9 14347.6 14549.3 14549.5 14568.1 14601.3 7184.0 8232.3 8284.8 8360.9 8373.7 8144.3 8192.4 8340.5 8341.5 8354.1 4431.6 4494.3 4505.2 4529.3 4590.7 1632.5 1841.6 1878.7 1894.6 1905.9 365.7 382.1 398.8 423.2 793.5 11479.1 11517.9 11604.1 11783.8 12041.7 415.6 418.9 429.9 441.7 442.2 5994.7 6004.2 6039.3 6068.8 6174.6 591400.0 602583.0 606760.0 609096.0 612239.0 125732.4 128381.0 133550.3 134078.7 135712.3 428.9 436.2 436.7 441.9 443.1 10967.3 11011.1 11034.3 11054.0 11064.4 44646.3 46101.1 46579.0 51656.0 54176.5 66442.3 67400.3 68072.3 68312.7 68840.0 5604.6 7340.8 7842.6 8129.4 8366.7 11750.3 12383.7 12467.9 12967.2 13040.0 10692.1 10752.9 10818.5 11122.4 11166.8 9580.7 10797.8 10871.7 11136.4 11211.8 10082.9 10971.8 11213.2 11407.7 11444.1 7976.4 7997.7 8037.8 8056.3 8095.8 9851.4 10636.1 10763.4 10913.2 11124.5 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#3] mootools.html Cycles:180 Average:5419.42 Median:5105.13 stddev:2997.57 (58.7%) stddev-sans-first:2989.84 18:19:39 INFO - PROCESS | 1630 | Values: 1281.1 1363.1 1483.0 1652.7 1873.2 7475.8 7844.4 8172.2 8439.0 8452.0 8271.0 8374.3 8381.8 8384.5 8390.2 2295.7 2341.3 2343.1 2344.8 2347.1 2052.7 2310.6 2361.2 2375.7 2382.8 2303.6 2310.7 2334.5 2337.1 2341.4 2246.8 2283.2 2314.1 2315.5 2316.4 1921.9 2158.6 2187.5 2188.3 2188.9 8034.6 8192.2 8199.5 8391.2 8409.2 4754.6 5269.4 5274.1 5274.5 5282.5 3136.4 3249.9 3546.2 3616.3 3628.3 1068.4 1084.7 1100.6 1102.0 1106.7 10936.2 10951.6 11023.2 11032.2 11044.0 4323.2 4353.1 4493.1 4509.0 4529.8 8693.0 8714.6 8740.4 8748.5 8753.0 5103.9 5106.4 5108.8 5115.6 5116.1 4242.0 4384.1 4466.9 4676.9 4739.3 3629.9 3658.7 3716.1 3758.2 3765.6 1144.9 1154.6 1154.9 1163.4 1164.4 791.7 806.4 814.8 819.9 888.2 5368.6 5556.2 5574.3 5825.1 5971.6 849.1 894.3 907.5 909.8 916.8 3345.9 3714.6 3754.7 3824.2 3851.7 9939.5 10243.0 10352.4 10358.3 10362.0 8274.9 10152.7 10195.9 10322.3 10323.6 7807.8 7890.4 8002.5 8013.4 8028.2 4908.6 5410.3 5487.6 5711.9 5716.8 9295.4 9314.6 9350.1 9475.4 9534.0 9450.9 9583.9 9591.0 9702.4 9717.7 6253.6 6353.5 6816.8 6833.6 6948.1 8058.3 8146.7 8146.8 8157.5 8162.3 6394.8 7118.9 7201.1 7230.9 7280.2 6919.3 7132.8 7157.8 7179.3 7284.1 6706.8 6764.3 6786.4 6836.2 6885.9 4872.1 4904.5 4904.5 4936.1 4955.0 4827.1 4882.8 4890.1 4983.1 5003.1 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#4] prototype.html Cycles:180 Average:4283.44 Median:4761.42 stddev:1296.76 (27.2%) stddev-sans-first:1265.31 18:19:39 INFO - PROCESS | 1630 | Values: 291.5 298.3 305.8 309.8 311.7 4432.8 4705.4 5042.0 5057.0 5141.5 3861.8 4215.8 4330.4 4422.5 5047.8 3136.9 3333.2 3631.0 3963.8 3990.0 3810.9 3974.1 3976.9 4001.2 4005.2 3458.3 3600.3 3931.3 3938.9 3962.9 3898.8 3908.5 3928.8 3943.2 3950.5 3145.8 3187.3 3428.5 3447.0 3454.9 4715.4 4733.6 4996.7 4998.0 5014.9 4112.5 4470.8 4492.3 4512.1 4519.2 4521.4 4976.4 5290.4 5377.0 5466.4 3160.4 3449.6 3752.2 3753.2 3779.4 4719.7 5331.5 5655.8 5681.9 5686.9 3756.3 3787.5 3809.3 3812.5 3826.4 3875.9 3882.9 3893.8 3894.7 3900.5 4077.7 4129.1 4140.7 4156.8 4424.8 5366.7 5389.8 5411.5 5418.1 5419.4 1169.6 1182.2 1222.4 1240.0 1243.3 788.9 796.4 808.3 810.8 828.9 4742.3 4743.0 4769.9 4777.9 4838.9 4521.7 4582.5 4854.4 5060.5 5247.2 4488.6 4688.2 4887.9 5234.7 5280.6 2582.6 2781.3 2812.6 2824.9 2825.3 4796.0 5199.4 5451.5 5473.8 5514.9 4817.6 5122.1 5336.0 5395.4 5450.7 5033.4 5383.7 5452.0 5464.5 5470.3 4552.9 5098.9 5118.5 5166.9 5305.3 4612.6 4854.7 4975.4 5276.9 5284.8 4856.4 5115.9 5391.3 5443.7 5446.0 3222.6 3510.9 3591.9 3601.5 3627.5 4688.5 4905.3 4935.6 5612.6 5672.2 4752.9 5310.7 5450.5 5481.3 5485.7 4553.2 4771.3 4876.3 5318.7 5391.9 5090.2 5273.4 5332.2 5345.8 5347.5 5302.7 5332.9 5494.7 5506.9 5512.9 4772.6 4958.7 5324.6 5410.2 5430.7 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - PROCESS | 1630 | [#5] yui.html Cycles:180 Average:20189.58 Median:4143.80 stddev:29940.77 (722.5%) stddev-sans-first:29988.64 18:19:39 INFO - PROCESS | 1630 | Values: 602.9 691.1 694.5 727.1 760.6 13894.4 14207.2 14283.9 14474.8 14571.3 12838.6 13124.2 13137.1 13145.7 13157.7 793.7 804.1 817.6 818.6 819.3 801.8 817.5 818.4 818.4 818.7 872.5 872.9 873.2 873.6 873.6 866.8 866.9 867.2 868.2 868.3 640.4 640.6 642.0 642.1 642.3 13429.5 14320.2 14447.5 14453.8 14454.4 12617.2 12959.7 13007.8 13014.3 13023.0 9573.2 9957.0 9958.3 10047.0 10056.5 3489.2 3577.5 3632.6 3686.4 3773.7 83532.0 88656.0 88860.6 89131.1 89872.6 10025.2 10127.0 10216.7 10262.3 10447.3 19390.9 20182.7 20209.3 20359.1 20410.3 7404.7 7455.3 7506.6 7564.2 7739.0 4035.0 4095.0 4129.2 4382.6 4393.5 3087.3 3398.8 3402.8 3516.2 3522.0 626.6 632.5 633.0 638.5 651.6 555.6 562.8 601.8 648.4 658.9 8451.8 8781.6 8784.4 8876.1 9017.0 532.5 613.0 641.5 658.8 674.8 3734.9 3902.4 4001.2 4158.4 4189.4 104335.0 109271.0 113351.0 114039.4 117550.4 58789.0 72724.6 90846.0 98763.5 102614.5 88295.0 88336.0 90679.0 91145.2 91621.5 8842.0 9228.8 9284.5 9534.0 9731.5 38324.0 38409.8 51351.0 52815.2 54222.0 70347.7 76097.6 78598.0 80770.6 80912.0 11699.8 11811.9 12066.2 12090.3 12236.5 11531.6 13977.5 14143.2 14206.6 14577.6 10839.0 12554.4 12617.0 13050.0 13616.4 12697.9 12957.9 13049.2 13084.3 13651.5 12252.3 12369.3 12388.3 12409.8 12475.9 10361.6 10887.5 11031.4 11055.5 11419.6 10892.8 11114.8 11142.8 11308.5 11353.5 18:19:39 INFO - PROCESS | 1630 | -------- Summary: end -------- 18:19:39 INFO - PROCESS | 1630 | 18:19:39 INFO - TEST-INFO | 1630: exit 0 18:19:39 INFO - TEST-OK | dromaeo_css | took 1119125ms 18:19:39 INFO - TEST-START | kraken 18:19:39 INFO - operating with platform_type : mac_ 18:19:39 INFO - Initialising browser for kraken test... 18:19:39 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpRcLzCM/profile http://localhost:49239/getInfo.html) 18:19:42 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 18:19:42 INFO - PROCESS | 1639 | colorDepth:24 18:19:42 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 18:19:42 INFO - PROCESS | 1639 | __metrics 18:19:42 INFO - PROCESS | 1639 | 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" 18:19:42 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:43 INFO - TEST-INFO | 1639: exit 0 18:19:43 INFO - Browser initialized. 18:19:43 INFO - Running cycle 1/1 for kraken test... 18:19:43 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpRcLzCM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:55 INFO - PROCESS | 1640 | RSS: Main: 222371840 18:19:55 INFO - PROCESS | 1640 | 18:19:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 18:19:59 INFO - PROCESS | 1640 | RSS: Main: 272293888 18:19:59 INFO - PROCESS | 1640 | 18:20:01 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 18:20:02 INFO - PROCESS | 1640 | RSS: Main: 283537408 18:20:02 INFO - PROCESS | 1640 | 18:20:05 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 18:20:06 INFO - PROCESS | 1640 | RSS: Main: 379715584 18:20:06 INFO - PROCESS | 1640 | 18:20:08 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 18:20:08 INFO - PROCESS | 1640 | RSS: Main: 282845184 18:20:08 INFO - PROCESS | 1640 | 18:20:10 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:11 INFO - PROCESS | 1640 | RSS: Main: 283779072 18:20:11 INFO - PROCESS | 1640 | 18:20:14 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:14 INFO - PROCESS | 1640 | RSS: Main: 323403776 18:20:14 INFO - PROCESS | 1640 | 18:20:17 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:18 INFO - PROCESS | 1640 | RSS: Main: 324812800 18:20:18 INFO - PROCESS | 1640 | 18:20:20 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 18:20:21 INFO - PROCESS | 1640 | RSS: Main: 325353472 18:20:21 INFO - PROCESS | 1640 | 18:20:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:23 INFO - PROCESS | 1640 | RSS: Main: 300244992 18:20:23 INFO - PROCESS | 1640 | 18:20:25 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:26 INFO - PROCESS | 1640 | RSS: Main: 300232704 18:20:26 INFO - PROCESS | 1640 | 18:20:28 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:29 INFO - PROCESS | 1640 | RSS: Main: 302669824 18:20:29 INFO - PROCESS | 1640 | 18:20:31 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:32 INFO - PROCESS | 1640 | RSS: Main: 313339904 18:20:32 INFO - PROCESS | 1640 | 18:20:35 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:36 INFO - PROCESS | 1640 | RSS: Main: 313077760 18:20:36 INFO - PROCESS | 1640 | 18:20:37 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 18:20:38 INFO - PROCESS | 1640 | RSS: Main: 356978688 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | __start_tp_report 18:20:38 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 18:20:38 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 18:20:38 INFO - PROCESS | 1640 | |i|pagename|runs| 18:20:38 INFO - PROCESS | 1640 | |0;ai-astar;116;113;115;115;115;116;116;115;115;123 18:20:38 INFO - PROCESS | 1640 | |1;audio-beat-detection;168;130;108;144;109;111;110;109;140;107 18:20:38 INFO - PROCESS | 1640 | |2;audio-dft;185;185;186;183;184;186;185;184;183;186 18:20:38 INFO - PROCESS | 1640 | |3;audio-fft;83;58;59;90;58;57;59;61;82;58 18:20:38 INFO - PROCESS | 1640 | |4;audio-oscillator;87;70;94;70;69;68;90;68;69;91 18:20:38 INFO - PROCESS | 1640 | |5;imaging-gaussian-blur;92;89;91;88;91;88;91;88;91;87 18:20:38 INFO - PROCESS | 1640 | |6;imaging-darkroom;95;96;95;97;96;96;97;95;95;96 18:20:38 INFO - PROCESS | 1640 | |7;imaging-desaturate;82;85;81;80;81;81;84;85;83;84 18:20:38 INFO - PROCESS | 1640 | |8;json-parse-financial;55;54;54;53;56;57;57;58;56;56 18:20:38 INFO - PROCESS | 1640 | |9;json-stringify-tinderbox;66;68;70;77;72;70;69;71;70;71 18:20:38 INFO - PROCESS | 1640 | |10;stanford-crypto-aes;81;82;84;92;94;98;94;77;83;89 18:20:38 INFO - PROCESS | 1640 | |11;stanford-crypto-ccm;140;140;136;138;141;143;137;159;203;178 18:20:38 INFO - PROCESS | 1640 | |12;stanford-crypto-pbkdf2;167;167;168;165;169;167;166;168;166;200 18:20:38 INFO - PROCESS | 1640 | |13;stanford-crypto-sha256-iterative;63;65;67;68;66;67;67;67;66;67 18:20:38 INFO - PROCESS | 1640 | __end_tp_report 18:20:38 INFO - PROCESS | 1640 | __start_cc_report 18:20:38 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1996 18:20:38 INFO - PROCESS | 1640 | __end_cc_report 18:20:38 INFO - PROCESS | 1640 | __startTimestamp1484965238136__endTimestamp 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | ------- Summary: start ------- 18:20:38 INFO - PROCESS | 1640 | Number of tests: 14 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:2.64 (2.3%) stddev-sans-first:2.80 18:20:38 INFO - PROCESS | 1640 | Values: 116.0 113.0 115.0 115.0 115.0 116.0 116.0 115.0 115.0 123.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:120.50 stddev:21.05 (17.5%) stddev-sans-first:14.98 18:20:38 INFO - PROCESS | 1640 | Values: 168.0 130.0 108.0 144.0 109.0 111.0 110.0 109.0 140.0 107.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.16 (0.6%) stddev-sans-first:1.22 18:20:38 INFO - PROCESS | 1640 | Values: 185.0 185.0 186.0 183.0 184.0 186.0 185.0 184.0 183.0 186.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.00 stddev:12.97 (21.6%) stddev-sans-first:12.31 18:20:38 INFO - PROCESS | 1640 | Values: 83.0 58.0 59.0 90.0 58.0 57.0 59.0 61.0 82.0 58.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.25 (14.3%) stddev-sans-first:11.40 18:20:38 INFO - PROCESS | 1640 | Values: 87.0 70.0 94.0 70.0 69.0 68.0 90.0 68.0 69.0 91.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:91.00 stddev:1.78 (2.0%) stddev-sans-first:1.66 18:20:38 INFO - PROCESS | 1640 | Values: 92.0 89.0 91.0 88.0 91.0 88.0 91.0 88.0 91.0 87.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 18:20:38 INFO - PROCESS | 1640 | Values: 95.0 96.0 95.0 97.0 96.0 96.0 97.0 95.0 95.0 96.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#7] imaging-desaturate Cycles:10 Average:82.60 Median:83.50 stddev:1.84 (2.2%) stddev-sans-first:1.94 18:20:38 INFO - PROCESS | 1640 | Values: 82.0 85.0 81.0 80.0 81.0 81.0 84.0 85.0 83.0 84.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.66 18:20:38 INFO - PROCESS | 1640 | Values: 55.0 54.0 54.0 53.0 56.0 57.0 57.0 58.0 56.0 56.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:2.88 (4.1%) stddev-sans-first:2.57 18:20:38 INFO - PROCESS | 1640 | Values: 66.0 68.0 70.0 77.0 72.0 70.0 69.0 71.0 70.0 71.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:90.50 stddev:6.93 (7.7%) stddev-sans-first:6.95 18:20:38 INFO - PROCESS | 1640 | Values: 81.0 82.0 84.0 92.0 94.0 98.0 94.0 77.0 83.0 89.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:142.00 stddev:22.34 (15.7%) stddev-sans-first:23.30 18:20:38 INFO - PROCESS | 1640 | Values: 140.0 140.0 136.0 138.0 141.0 143.0 137.0 159.0 203.0 178.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:167.50 stddev:10.50 (6.3%) stddev-sans-first:11.07 18:20:38 INFO - PROCESS | 1640 | Values: 167.0 167.0 168.0 165.0 169.0 167.0 166.0 168.0 166.0 200.0 18:20:38 INFO - PROCESS | 1640 | 18:20:38 INFO - PROCESS | 1640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:0.87 18:20:38 INFO - PROCESS | 1640 | Values: 63.0 65.0 67.0 68.0 66.0 67.0 67.0 67.0 66.0 67.0 18:20:38 INFO - PROCESS | 1640 | -------- Summary: end -------- 18:20:38 INFO - PROCESS | 1640 | 18:20:39 INFO - TEST-INFO | 1640: exit 0 18:20:39 INFO - TEST-OK | kraken | took 59558ms 18:20:39 INFO - SUITE-END | took 1178s 18:20:39 INFO - Completed test suite (00:19:38) 18:20:39 INFO - javascript benchmark 18:20:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.1422230220137, 3310.9834450827743, 3315.0717799016275, 3339.7662163648524, 3367.0, 4790.496997815231, 5637.943620563793, 5676.403977582357, 5687.459691329317, 5731.1689804978305, 5655.604107712462, 5659.632123911953, 5704.030314846475, 5731.312242530902, 5798.304203495586, 5179.741012949356, 5180.6891586504935, 5194.63637545372, 5247.265382846385, 5267.578593712494, 5156.252343410203, 5164.561012313958, 5185.092608793446, 5219.243209734586, 5339.492748188935, 5248.134057880445, 5307.363116426015, 5320.813771517997, 5326.733663316838, 5352.518273355417, 5301.522862942315, 5308.150695888678, 5308.92036619451, 5312.654677445992, 5363.249145119687, 4990.750462476862, 5124.4106927703415, 5232.9738351308, 5239.056969745444, 5251.133562962144, 5647.717614119319, 5648.096304591246, 5686.2039314496005, 5772.2496075510335, 5774.105013722879, 5265.552428043583, 6180.2892667343385, 6216.409441103088, 6256.843578910563, 6275.121482992385, 6265.467435268008, 6274.686265686697, 6276.964300890348, 6279.183706118175, 6312.968435157841, 5642.181883626892, 5651.095824668075, 5718.999175144333, 5782.479576838021, 5861.120831875252, 6212.960336771669, 6223.844403889939, 6236.158118654014, 6244.438000579969, 6251.12484252205, 6119.479844213202, 6144.631322120687, 6151.231096112986, 6164.5684802064325, 6170.568060235741, 6102.284011916584, 6168.167297414791, 6196.039613859859, 6256.562040657111, 6257.749690012349, 6258.217722784652, 6262.279837818709, 6271.996480563088, 6273.059041143773, 6274.968625156845, 6207.472364848948, 6224.066390041439, 6252.374762523711, 6286.402791734778, 6286.5599408041, 4827.565519103227, 4874.0, 4879.487653796371, 4906.975465122651, 5002.97439024999, 4420.292753159479, 4444.444444444444, 4451.710638808467, 4467.463904331436, 4505.594496495331, 5743.511801496919, 5777.306723193244, 5786.291124637013, 5788.305403351625, 5824.621399609012, 6100.633961962297, 6106.664133472702, 6287.2140982377205, 6306.936930630727, 6311.905321420182, 5668.886622267614, 5670.121131224667, 5689.630174038674, 5705.887351966409, 5753.079507278815, 5376.838694839161, 5423.0, 5427.0773968425465, 5434.70109143993, 5447.0, 6268.623882567061, 6274.6548939808745, 6282.340354262737, 6289.150964619717, 6310.337414571404, 5967.194428752063, 6103.6032657877095, 6111.052786818051, 6212.378762123752, 6297.244330680164, 6250.156228909039, 6270.216222972129, 6274.341194174546, 6288.213973253343, 6291.02489114188, 6170.352113028068, 6212.161358216764, 6233.501319894488, 6234.127222188807, 6235.594686345373, 5650.886982260414, 6040.731446396306, 6127.509799215963, 6143.358355907003, 6212.161358216764, 5121.206213036985, 6033.78881739137, 6059.939400606114, 6088.208532890873, 6132.355508992456, 5942.197803296673, 6029.155918171372, 6084.482818960261, 6092.208012958287, 6125.693715314305, 5859.531237501075, 5885.735141918538, 5897.498712609477, 5933.110033495011, 5936.257967754031, 4993.375828021497, 5923.0, 5956.0, 5978.252718410199, 5980.0, 5882.794102206402, 5896.8820623586425, 5897.823065308047, 5900.085486749561, 5932.139839723302], "value": 5674.1299098214295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.89860230749264, 471.73111326543886, 477.23642172523955, 490.374772165489, 520.778669065647, 29127.854360728194, 30682.84658576704, 30684.84657576709, 30688.84655576719, 30716.53925191121, 31516.842415787945, 31803.0, 31948.0, 39836.60163398365, 40424.79787601065, 8700.477971321741, 8913.841200643907, 9215.354925155241, 9367.81264374712, 9382.85925711115, 9206.539673016356, 9308.441493510378, 9314.86027709585, 9317.906820931805, 9328.48693321867, 8373.07896131428, 8591.656333746643, 9298.20965217954, 10947.34315941042, 11296.491657875415, 11122.666320010412, 11207.159463040223, 11223.775524489505, 11236.943815280953, 11241.831372529337, 8311.459755115899, 11128.554857805759, 11191.2725672831, 11195.440227988567, 11212.607558735486, 29383.853080734672, 37606.811965940266, 38120.80939595312, 38197.0, 39577.60422395768, 3196.4246435641576, 3279.5244689519886, 3303.96696033039, 3436.244026314207, 3841.135744457503, 27149.06829197681, 27734.8906043758, 28715.425691486264, 28761.56857647137, 29812.701872981208, 3111.828849413281, 3175.6348019977536, 3179.984100079508, 3226.677332266778, 3231.1922019495128, 500143.0, 501533.0, 503933.0, 504939.0, 513133.0, 48118.0, 49393.50606493961, 53701.462985370425, 56452.0, 56963.430365696644, 56623.433765661815, 59458.70270648619, 59475.0, 59483.405165947785, 59520.0, 15331.463398780988, 15443.459478918185, 15468.767968480483, 15473.767893481607, 15475.535733928, 11910.106741994385, 11988.460519276654, 12000.519979200733, 12005.819912701316, 12030.157888947864, 13536.932315338558, 15324.846751532565, 15330.693386132214, 15423.074615523105, 15440.382384704712, 5040.873978150576, 5210.140326846104, 6021.0, 6123.877522449526, 6456.967715161394, 852.8933883264592, 877.731677725693, 924.8795574852803, 1022.8414595737672, 1059.885528370905, 27002.53895554323, 28324.0, 28569.857150714113, 28945.565816512768, 29028.709712903023, 853.3685073045901, 1066.4294602387686, 1106.2975010868156, 1113.9554417823358, 1181.5628217559558, 14416.351264193136, 14782.630434239016, 14913.478028268959, 15214.16322102295, 15360.385584576716, 644779.0, 646670.7666461638, 647367.0, 648011.0, 650450.0, 46145.76927115343, 54667.45332546703, 54708.72645636746, 54964.72517637386, 55031.44968550343, 1329.2821876186945, 1353.4383230959043, 1385.2865774126333, 1385.5773988933472, 1386.209860379574, 27549.0, 27585.724142758314, 27892.02377916763, 28623.0, 28660.85669571639, 41173.0, 46966.29550556813, 47125.764371177924, 47198.05603887972, 47240.055198896516, 590721.0, 591152.0, 592229.0, 592563.0, 592648.0, 25141.120060797784, 25259.74740252574, 25421.0, 25425.61861572041, 25450.618240726035, 43454.34818477662, 43723.781381094166, 43946.34080488731, 44826.77586612046, 45113.77443112763, 32513.374331283816, 36169.0957726059, 36847.973361465374, 36860.0, 37302.8134859324, 35762.0, 36822.44766328561, 36963.0, 37068.25863482661, 37696.43455348117, 36308.63691363052, 37046.629533705396, 37072.88781336564, 37686.62313376941, 38289.80855095707, 25037.0, 28278.85860570684, 30662.0, 32982.670173297956, 33000.66999329976, 20568.177272908917, 21289.68065478988, 24709.0, 24801.25596232116, 24985.000599975796], "value": 18876.063489865704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.93029463812604, 336.50365710576887, 352.4378616107311, 380.6612115217457, 400.8116185392866, 14402.855971440282, 14586.92706536467, 15384.538463846075, 16446.588835279123, 19873.900630496864, 18921.526961825963, 19462.513437164078, 20536.38390848277, 20546.69179962302, 20634.89682551585, 5702.914456283149, 5887.322957859837, 5903.793367232148, 5907.0, 6033.728482218311, 4987.576056035241, 5929.584929054968, 6000.819975400745, 6061.45446909778, 6066.726997285133, 6012.969935150318, 6015.639061656293, 6016.699165041752, 6019.909701354483, 6023.789167379143, 5682.602217844753, 5951.434613711691, 5969.462748352669, 5983.820485385445, 5984.73068711909, 5072.746362681851, 5199.324087868591, 5218.504242096995, 5222.660527065728, 5228.843134705965, 12515.186512876633, 13215.66960825987, 13224.14043087206, 13226.272555009471, 13809.654758631115, 2151.5159089204803, 2215.3464727905143, 2217.2904670505445, 2269.795718385337, 2296.1619009061737, 9217.677381291622, 9636.0, 9888.802223955552, 10188.490575471196, 10206.489675516195, 1645.465223802257, 1738.774164214226, 1791.3730194431976, 1814.528222662104, 1837.5865430278213, 102622.0, 104502.0, 109649.93850676419, 111041.99999999919, 111654.0, 11283.717907052225, 11375.033122184706, 11574.0, 11580.76838463226, 11736.94131529354, 14347.56957291283, 14549.254089509326, 14549.490767823076, 14568.05307654999, 14601.342939567745, 7183.964080179566, 8232.259096681328, 8284.751457456287, 8360.874586881202, 8373.748787536384, 8144.30773384269, 8192.426530142951, 8340.541270230196, 8341.541215233221, 8354.122817104238, 4431.578999994996, 4494.303382975644, 4505.211587972158, 4529.275315949432, 4590.678652494294, 1632.4939268826465, 1841.5672317005492, 1878.7369768232459, 1894.602133551942, 1905.8856468611928, 365.6508034826734, 382.14590390477815, 398.7846562856025, 423.1917038456533, 793.4604468961046, 11479.081673466102, 11517.884821151682, 11604.071674266039, 11783.823242651368, 12041.698957525956, 415.5553557693239, 418.94553708017764, 429.9161663475592, 441.69523029109814, 442.16210281516345, 5994.67029313392, 6004.249468816398, 6039.275286965504, 6068.848278793065, 6174.598651087665, 591400.0, 602583.0, 606760.0, 609096.0, 612239.0, 125732.37133814272, 128381.0, 133550.33224834007, 134078.65921340857, 135712.32143839414, 428.8777698356016, 436.1625678696846, 436.6681322195091, 441.86964845370693, 443.08945117783264, 10967.287126336763, 11011.064059555027, 11034.282771619819, 11054.0, 11064.446777661246, 44646.3303050448, 46101.07797843957, 46579.0, 51656.0, 54176.458235418715, 66442.33557664555, 67400.2929838844, 68072.3192768066, 68312.6584367075, 68840.0, 5604.607677462538, 7340.788769852915, 7842.568658723597, 8129.390295727962, 8366.748997530083, 11750.294982300748, 12383.690407739517, 12467.93766031164, 12967.157134786208, 13040.0, 10692.14462842955, 10752.946235268773, 10818.459077045958, 11122.44387780624, 11166.832497512381, 9580.66467673628, 10797.838032429363, 10871.728206794893, 11136.443177841238, 11211.831822522832, 10082.949585252027, 10971.83542246851, 11213.15901307389, 11407.657770266906, 11444.141689373497, 7976.401769867167, 7997.720079797179, 8037.7588672339925, 8056.274935255855, 8095.83808323842, 9851.359661621971, 10636.149108071491, 10763.354198747787, 10913.18151138652, 11124.499397527292], "value": 8175.077655879693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.1096288079789, 1363.1480324797, 1483.0212060040371, 1652.6612044530873, 1873.2132504348172, 7475.813104672379, 7844.372450203984, 8172.1827817218245, 8438.957805210965, 8451.957740211306, 8271.048829384623, 8374.288185504225, 8381.832363352745, 8384.496930184194, 8390.202930721573, 2295.6671282664006, 2341.3327201747506, 2343.121329501437, 2344.824138189643, 2347.108098922407, 2052.702358158066, 2310.572544079342, 2361.1853910400882, 2375.6911601491784, 2382.761723827612, 2303.6429353450158, 2310.722713274409, 2334.5214231082587, 2337.1118974789556, 2341.426350544119, 2246.8202543796456, 2283.178055899875, 2314.0743702518957, 2315.5368926214824, 2316.397736588482, 1921.875702713914, 2158.6222411077997, 2187.5187458759046, 2188.321620297713, 2188.89055547222, 8034.558099304536, 8192.18078192182, 8199.467034642788, 8391.160883911622, 8409.159084091603, 4754.643401744883, 5269.367675878919, 5274.129768588178, 5274.498922602346, 5282.524572788468, 3136.4197623439736, 3249.886253981123, 3546.202104526487, 3616.3490571697084, 3628.274345130958, 1068.4444089073716, 1084.728817795551, 1100.5597760895625, 1101.9889801101967, 1106.673531308266, 10936.179786516042, 10951.616693415692, 11023.228374013823, 11032.172587056002, 11044.0, 4323.156984388014, 4353.085851971058, 4493.1013797240685, 4508.954910450919, 4529.773511324421, 8693.0, 8714.607842647096, 8740.388172827841, 8748.47509149453, 8753.0, 5103.897922041612, 5106.361704786902, 5108.821191258288, 5115.56517696, 5116.104681680691, 4242.024334403043, 4384.079343337935, 4466.888327791831, 4676.906461870812, 4739.336492890998, 3629.9092522686615, 3658.689011434005, 3716.0524066362905, 3758.1732018955786, 3765.585785563586, 1144.9313041217554, 1154.6478324111226, 1154.8787377325427, 1163.4299193395175, 1164.4061528620464, 791.7308115240846, 806.3871457692196, 814.767791179511, 819.9262066414051, 888.1606881496923, 5368.624196306221, 5556.249906262603, 5574.275344205227, 5825.126231065289, 5971.611845230046, 849.1126772522605, 894.2577660541734, 907.5144797533288, 909.8225845960106, 916.8166366726681, 3345.882894098695, 3714.5542534895985, 3754.718396120302, 3824.2351529694174, 3851.7496362736333, 9939.50302484873, 10243.0, 10352.430616316175, 10358.274920755626, 10362.0, 8274.875876861852, 10152.695419137437, 10195.898041019494, 10322.277440579088, 10323.587056517656, 7807.804804879924, 7890.368770498347, 8002.519848809206, 8013.439059265912, 8028.197180282042, 4908.631852610997, 5410.296661433988, 5487.560995120461, 5711.942880571141, 5716.79991200306, 9295.442273463614, 9314.580843861906, 9350.064993500595, 9475.431474111576, 9534.046595340411, 9450.858237126311, 9583.904160958302, 9591.040895910353, 9702.417854928726, 9717.6598819041, 6253.5622506424115, 6353.491720662243, 6816.829579260559, 6833.555818871758, 6948.131483564554, 8058.274755272054, 8146.674133034612, 8146.837063258583, 8157.469764465291, 8162.347012239125, 6394.840128996812, 7118.928810711826, 7201.099862517185, 7230.89153662706, 7280.235575264521, 6919.308069193041, 7132.750353737594, 7157.821054473679, 7179.317964793337, 7284.125904891447, 6706.798796036127, 6764.323567643393, 6786.355296246848, 6836.213835408992, 6885.862282754217, 4872.098661747588, 4904.5340692634145, 4904.534069263557, 4936.136176169084, 4954.9752251238515, 4827.131116399082, 4882.755862206946, 4890.070886531547, 4983.103041452428, 5003.124453220599], "value": 4371.502753314422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.50444244783876, 298.34959787662893, 305.79817320568424, 309.84972288440116, 311.68364110427905, 4432.764082219981, 4705.3766450574585, 5042.0168067226905, 5057.0, 5141.537261646451, 3861.7876016819064, 4215.789210539476, 4330.3504474328865, 4422.4963512405775, 5047.798088076473, 3136.8588413521447, 3333.1500467380783, 3630.963690363089, 3963.7621742695387, 3990.0024993751563, 3810.8856734298015, 3974.052714170065, 3976.880693579197, 4001.159756451149, 4005.2390045891334, 3458.291050334675, 3600.261946301002, 3931.292367373886, 3938.8818335449982, 3962.881113566598, 3898.785566793825, 3908.511436070491, 3928.7839168845703, 3943.211357728437, 3950.5456872459604, 3145.811251324928, 3187.2509960159346, 3428.5200071989943, 3446.9827650861585, 3454.8790792322147, 4715.386999690053, 4733.633183408296, 4996.675216110941, 4997.950430409618, 5014.874628134289, 4112.465379500646, 4470.798814053375, 4492.258777301741, 4512.052468981517, 4519.2091384008, 4521.434820647419, 4976.402831660224, 5290.365156181244, 5377.0, 5466.426025267329, 3160.4153231652217, 3449.5515582974303, 3752.212035472554, 3753.193063491335, 3779.433085037266, 4719.740414277179, 5331.546818520431, 5655.802046928337, 5681.857953551194, 5686.857828554319, 3756.3096606527174, 3787.5265591801026, 3809.3333666608232, 3812.4853144825092, 3826.4069069293746, 3875.9031024224055, 3882.902927426837, 3893.785841778673, 3894.727369084137, 3900.473436086149, 4077.734947228421, 4129.112240868228, 4140.701910439675, 4156.8129434175535, 4424.80088396023, 5366.731663416892, 5389.8113566025, 5411.538884501163, 5418.103663717668, 5419.430959749248, 1169.5672601137633, 1182.2079206931376, 1222.3986577583394, 1239.9938000309942, 1243.3348158735034, 788.8895554622358, 796.3748457460865, 808.2604416958417, 810.801353668355, 828.8632375657949, 4742.264948932921, 4742.952570474251, 4769.928451073237, 4777.904441911142, 4838.854834354975, 4521.706089104197, 4582.450105987303, 4854.393200849894, 5060.51925067118, 5247.16045432729, 4488.551144885485, 4688.179134005774, 4887.853364399074, 5234.712090834964, 5280.6467892888295, 2582.6384306197147, 2781.2629653141935, 2812.6343575335077, 2824.943501129966, 2825.321922738569, 4796.0, 5199.428062913076, 5451.536619387396, 5473.808416705396, 5514.944850551524, 4817.614590832725, 5122.106010104354, 5336.0, 5395.379531353866, 5450.683459529684, 5033.439633713488, 5383.730813459311, 5452.0, 5464.513646290928, 5470.261514695545, 4552.884543286916, 5098.923516147335, 5118.539331460186, 5166.948330516797, 5305.336832895888, 4612.630989520763, 4854.708717476963, 4975.353204083591, 5276.868078298074, 5284.841454756363, 4856.368672072608, 5115.948840511547, 5391.29913111293, 5443.673379597237, 5446.0, 3222.564953731216, 3510.9473357900165, 3591.946120808242, 3601.459781032866, 3627.4558816176727, 4688.484266730588, 4905.302083853795, 4935.62982776286, 5612.607117501736, 5672.205891175321, 4752.904941901212, 5310.6813591184655, 5450.5367043801725, 5481.3141560635795, 5485.6982865942755, 4553.2259515881715, 4771.332013518179, 4876.341693871282, 5318.73953569739, 5391.919121213264, 5090.2364645303505, 5273.393559740679, 5332.214127969185, 5345.839624811262, 5347.545458636059, 5302.734863256745, 5332.893342133058, 5494.697791621499, 5506.91739623914, 5512.862178445571, 4772.594329481894, 4958.743771583849, 5324.6006549508165, 5410.185818997518, 5430.67415955044], "value": 3868.0509924662897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8837444129308, 691.084313284897, 694.5416025423218, 727.0802434919827, 760.5769278443543, 13894.444222231112, 14207.218602976858, 14283.928580357097, 14474.782878256821, 14571.27143642819, 12838.614841554745, 13124.212547247173, 13137.080404371698, 13145.67135821605, 13157.67105822355, 793.7420338390017, 804.0672819529333, 817.6198067898426, 818.643889907889, 819.2790344496834, 801.831615360772, 817.5176645778989, 818.3780326951501, 818.3862103422433, 818.7380038387719, 872.4939535069644, 872.8821609082756, 873.1835733589114, 873.5544872115236, 873.6330741088758, 866.7659731872359, 866.9089745576719, 867.176182626501, 868.2402897464718, 868.3053557154283, 640.4012248547576, 640.5676168586185, 641.977530786425, 642.1331202876127, 642.3127253838395, 13429.529966451226, 14320.212388318638, 14447.494337698236, 14453.78319325211, 14454.421823127062, 12617.242965422103, 12959.740805183843, 13007.804882926765, 13014.284214368206, 13022.999999999905, 9573.234141268751, 9956.95021524895, 9958.302918795687, 10047.0, 10056.547455364453, 3489.2498112905846, 3577.463380492921, 3632.5640923089136, 3686.3548878946344, 3773.716971227169, 83532.0, 88656.0, 88860.55569722175, 89131.10868891294, 89872.55063724706, 10025.19798416125, 10127.037931396506, 10216.693499195037, 10262.332948358333, 10447.268691191544, 19390.903045484964, 20182.697259541117, 20209.292674756314, 20359.08384122718, 20410.285640002825, 7404.666789994463, 7455.291747283999, 7506.62466876654, 7564.167941526428, 7739.0, 4034.9798251008556, 4094.9795251023556, 4129.15352352767, 4382.6055654991205, 4393.450818647669, 3087.336222712128, 3398.813065281384, 3402.8128452935325, 3516.1912760064815, 3522.0, 626.6490765171518, 632.4845251120322, 632.9556931014785, 638.4541217259269, 651.6383407209045, 555.5833125156133, 562.8142712904731, 601.8344955137372, 648.4229036157823, 658.9077529145924, 8451.830963380698, 8781.560921953876, 8784.429012114193, 8876.112388761072, 9017.0, 532.51541097601, 613.0, 641.4996302883758, 658.769430699261, 674.8211723893172, 3734.8879533614036, 3902.375619900859, 4001.2197621463533, 4158.438610787565, 4189.413482112506, 104335.0, 109271.0, 113351.0, 114039.42980285212, 117550.4122479382, 58789.0, 72724.63637681778, 90846.0, 98763.50618246863, 102614.48692756638, 88295.0, 88336.0, 90679.0, 91145.1770964577, 91621.54189229012, 8841.970952082043, 9228.815423691623, 9284.535773211448, 9533.952330238304, 9731.513424328614, 38324.0, 38409.807950960065, 51350.97298054093, 52815.207771882684, 54222.0, 70347.6870816249, 76097.6195119043, 78598.0, 80770.59614701889, 80912.0, 11699.824502632637, 11811.93692567673, 12066.215695979734, 12090.274583525017, 12236.510539578318, 11531.596394126502, 13977.510787122403, 14143.222122783345, 14206.644833879236, 14577.562673119823, 10839.0, 12554.435050422935, 12616.990640748902, 13050.0, 13616.38726257301, 12697.873021269668, 12957.870421295667, 13049.151805133015, 13084.28036458004, 13651.522196723066, 12252.326122063372, 12369.257844529357, 12388.256704597752, 12409.813852792035, 12475.875241247471, 10361.63734269297, 10887.510062047386, 11031.39327336972, 11055.502502387573, 11419.60031398897, 10892.836607451052, 11114.777704446027, 11142.777144457228, 11308.49111789955, 11353.48909299067], "value": 7138.794859273215, "unit": "score"}], "name": "dromaeo_css", "value": 6876.214789230537, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 115.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 123.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 130.0, 108.0, 144.0, 109.0, 111.0, 110.0, 109.0, 140.0, 107.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 186.0, 183.0, 184.0, 186.0, 185.0, 184.0, 183.0, 186.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 90.0, 58.0, 57.0, 59.0, 61.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 70.0, 69.0, 68.0, 90.0, 68.0, 69.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 91.0, 88.0, 91.0, 88.0, 91.0, 88.0, 91.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 81.0, 80.0, 81.0, 81.0, 84.0, 85.0, 83.0, 84.0], "value": 82.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 70.0, 77.0, 72.0, 70.0, 69.0, 71.0, 70.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 92.0, 94.0, 98.0, 94.0, 77.0, 83.0, 89.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 136.0, 138.0, 141.0, 143.0, 137.0, 159.0, 203.0, 178.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 168.0, 165.0, 169.0, 167.0, 166.0, 168.0, 166.0, 200.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1437.8, "alertThreshold": 2.0}]} 18:20:39 INFO - Return code: 0 18:20:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:20:39 INFO - # TBPL SUCCESS # 18:20:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:20:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:20:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:20:39 INFO - 2017-01-20 18:20:39.465 screenresolution[1644:10191] starting screenresolution argv=screenresolution get 18:20:39 INFO - 2017-01-20 18:20:39.468 screenresolution[1644:10191] Display 0: 1600x1200x32@60 18:20:39 INFO - 2017-01-20 18:20:39.474 screenresolution[1645:10194] starting screenresolution argv=screenresolution list 18:20:39 INFO - Available Modes on Display 0 18:20:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:20:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:20:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:20:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:20:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:20:39 INFO - Intel Iris: 18:20:39 INFO - Chipset Model: Intel Iris 18:20:39 INFO - Type: GPU 18:20:39 INFO - Bus: Built-In 18:20:39 INFO - VRAM (Dynamic, Max): 1536 MB 18:20:39 INFO - Vendor: Intel (0x8086) 18:20:39 INFO - Device ID: 0x0a2e 18:20:39 INFO - Revision ID: 0x0009 18:20:39 INFO - Displays: 18:20:39 INFO - Display: 18:20:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:20:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:20:39 INFO - Display Serial Number: 1600x1200 60 18:20:39 INFO - Main Display: Yes 18:20:39 INFO - Mirror: Off 18:20:39 INFO - Online: Yes 18:20:39 INFO - Rotation: Supported 18:20:39 INFO - Return code: 0 18:20:39 INFO - Running post-action listener: _resource_record_post_action 18:20:39 INFO - [mozharness: 2017-01-21 02:20:39.716734Z] Finished run-tests step (success) 18:20:39 INFO - Running post-run listener: _resource_record_post_run 18:20:39 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38962176; Write bytes: 661965824; Read time: 380; Write time: 1914 18:20:39 INFO - TinderboxPrint: CPU usage
53.7% 18:20:39 INFO - TinderboxPrint: I/O read bytes / time
38,962,176 / 380 18:20:39 INFO - TinderboxPrint: I/O write bytes / time
661,965,824 / 1,914 18:20:39 INFO - TinderboxPrint: CPU idle
2,245.8 (46.3%) 18:20:39 INFO - TinderboxPrint: CPU system
975.5 (20.1%) 18:20:39 INFO - TinderboxPrint: CPU user
1,628.3 (33.6%) 18:20:39 INFO - TinderboxPrint: Swap in / out
390,520,832 / 0 18:20:39 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 339368448; Write bytes: 336754688; Read time: 27570; Write time: 646 18:20:39 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37991424; Write bytes: 307483648; Read time: 363; Write time: 1216 18:20:40 INFO - Running post-run listener: _upload_blobber_files 18:20:40 INFO - Blob upload gear active. 18:20:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:40 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 18:20:40 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:20:40 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:20:40 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:41 INFO - (blobuploader) - INFO - Done attempting. 18:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:42 INFO - (blobuploader) - INFO - Done attempting. 18:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:45 INFO - (blobuploader) - INFO - Done attempting. 18:20:45 INFO - (blobuploader) - INFO - Iteration through files over. 18:20:45 INFO - Return code: 0 18:20:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:20:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:20:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9bbebb524aa665d16b1d081934ed01f1d30a15f01da3b230015296dbfb5ef1df5876db85873d32717f7675173db45f71d2dcf0e89832274c87ef8c835a09cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20488ca926f4e56f5200a01811cb954e03082d42c03ff8fd753725fb7a4e6c08f2cae303b88bec0f063aa9c6371ef96096c3ab52884fb609ed058bbd6172ed75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e31f5405162dc2945c744308fce4f26a45ac1762dad4676cdf86fd6c2708883239055312dedb114359426b12169c54b9d1ff062371c31be1fe5ce625874cdf2"} 18:20:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:20:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:20:45 INFO - Contents: 18:20:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9bbebb524aa665d16b1d081934ed01f1d30a15f01da3b230015296dbfb5ef1df5876db85873d32717f7675173db45f71d2dcf0e89832274c87ef8c835a09cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20488ca926f4e56f5200a01811cb954e03082d42c03ff8fd753725fb7a4e6c08f2cae303b88bec0f063aa9c6371ef96096c3ab52884fb609ed058bbd6172ed75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e31f5405162dc2945c744308fce4f26a45ac1762dad4676cdf86fd6c2708883239055312dedb114359426b12169c54b9d1ff062371c31be1fe5ce625874cdf2"} 18:20:45 INFO - Running post-run listener: copy_logs_to_upload_dir 18:20:45 INFO - Copying logs to upload dir... 18:20:45 INFO - mkdir: /builds/slave/test/build/upload/logs 18:20:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.292116 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-20 18:20:45.168845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 18:20:45.172076) ========= 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.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-Aurora/sha512/0e9bbebb524aa665d16b1d081934ed01f1d30a15f01da3b230015296dbfb5ef1df5876db85873d32717f7675173db45f71d2dcf0e89832274c87ef8c835a09cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20488ca926f4e56f5200a01811cb954e03082d42c03ff8fd753725fb7a4e6c08f2cae303b88bec0f063aa9c6371ef96096c3ab52884fb609ed058bbd6172ed75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e31f5405162dc2945c744308fce4f26a45ac1762dad4676cdf86fd6c2708883239055312dedb114359426b12169c54b9d1ff062371c31be1fe5ce625874cdf2"} build_url:https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/ZUxVq2knSMWphBduRp9JFg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9bbebb524aa665d16b1d081934ed01f1d30a15f01da3b230015296dbfb5ef1df5876db85873d32717f7675173db45f71d2dcf0e89832274c87ef8c835a09cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20488ca926f4e56f5200a01811cb954e03082d42c03ff8fd753725fb7a4e6c08f2cae303b88bec0f063aa9c6371ef96096c3ab52884fb609ed058bbd6172ed75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e31f5405162dc2945c744308fce4f26a45ac1762dad4676cdf86fd6c2708883239055312dedb114359426b12169c54b9d1ff062371c31be1fe5ce625874cdf2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 18:20:45.207125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 18:20:45.207508) ========= 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.SWNDhYMgKn/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.mXyb0naROR/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005036 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 18:20:45.255634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 18:20:45.255980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 18:20:45.256348) ========= ========= Total master_lag: 0.18 =========