builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0154 starttime: 1478341154.75 results: success (0) buildid: 20161105004017 builduid: ec95719e9c06458085be3ac8c3878bb2 revision: 69e17427242dc8063a7ad7d739247d4c47402da5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:14.751406) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:14.751816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:14.752360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:14.863269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:14.863649) ========= 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.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 --2016-11-05 03:19:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 142M=0s 2016-11-05 03:19:15 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.521229 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:15.447475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:15.447790) ========= 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.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.019580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:15.507462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 03:19:15.507766) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69e17427242dc8063a7ad7d739247d4c47402da5 --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 69e17427242dc8063a7ad7d739247d4c47402da5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 2016-11-05 03:19:15,588 truncating revision to first 12 chars 2016-11-05 03:19:15,589 Setting DEBUG logging. 2016-11-05 03:19:15,589 attempt 1/10 2016-11-05 03:19:15,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/69e17427242d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 03:19:16,774 unpacking tar archive at: mozilla-aurora-69e17427242d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.457910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 03:19:16.989139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:16.989442) ========= script_repo_revision: 69e17427242dc8063a7ad7d739247d4c47402da5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:16.989836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:16.990118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 03:19:17.009048) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 03:19:17.009446) ========= /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.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:19:17 INFO - MultiFileLogger online at 20161105 03:19:17 in /builds/slave/test 03:19:17 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 03:19:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:17 INFO - {'append_to_log': False, 03:19:17 INFO - 'base_work_dir': '/builds/slave/test', 03:19:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:19:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:17 INFO - 'branch': 'Mozilla-Aurora', 03:19:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:17 INFO - 'config_files': ('talos/mac_config.py',), 03:19:17 INFO - 'default_actions': ('clobber', 03:19:17 INFO - 'read-buildbot-config', 03:19:17 INFO - 'download-and-extract', 03:19:17 INFO - 'populate-webroot', 03:19:17 INFO - 'create-virtualenv', 03:19:17 INFO - 'install', 03:19:17 INFO - 'run-tests'), 03:19:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:17 INFO - 'download_minidump_stackwalk': True, 03:19:17 INFO - 'download_symbols': 'ondemand', 03:19:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:17 INFO - 'installer_path': 'installer.exe', 03:19:17 INFO - 'log_level': 'info', 03:19:17 INFO - 'log_name': 'talos', 03:19:17 INFO - 'log_to_console': True, 03:19:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:19:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:19:17 INFO - 'opt_config_files': (), 03:19:17 INFO - 'pip_index': False, 03:19:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:19:17 INFO - 'cmd': ('bash', 03:19:17 INFO - '-c', 03:19:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:19:17 INFO - 'enabled': True, 03:19:17 INFO - 'halt_on_failure': False, 03:19:17 INFO - 'name': 'check_screen_resolution'},), 03:19:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:19:17 INFO - 'cmd': ('bash', 03:19:17 INFO - '-c', 03:19:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:19:17 INFO - 'enabled': True, 03:19:17 INFO - 'halt_on_failure': False, 03:19:17 INFO - 'name': 'check_screen_resolution'},), 03:19:17 INFO - 'run_cmd_checks_enabled': True, 03:19:17 INFO - 'sps_profile': False, 03:19:17 INFO - 'sps_profile_interval': 0, 03:19:17 INFO - 'suite': 'dromaeojs', 03:19:17 INFO - 'system_bits': '32', 03:19:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:17 INFO - 'title': 't-yosemite-r7-0154', 03:19:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:17 INFO - 'use_talos_json': True, 03:19:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:17 INFO - 'work_dir': 'build'} 03:19:17 INFO - [mozharness: 2016-11-05 10:19:17.212579Z] Running clobber step. 03:19:17 INFO - Running pre-action listener: _resource_record_pre_action 03:19:17 INFO - Running main action method: clobber 03:19:17 INFO - rmtree: /builds/slave/test/build 03:19:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:18 INFO - Running post-action listener: _resource_record_post_action 03:19:18 INFO - [mozharness: 2016-11-05 10:19:18.124592Z] Finished clobber step (success) 03:19:18 INFO - [mozharness: 2016-11-05 10:19:18.124769Z] Running read-buildbot-config step. 03:19:18 INFO - Running pre-action listener: _resource_record_pre_action 03:19:18 INFO - Running main action method: read_buildbot_config 03:19:18 INFO - Using buildbot properties: 03:19:18 INFO - { 03:19:18 INFO - "project": "", 03:19:18 INFO - "product": "firefox", 03:19:18 INFO - "script_repo_revision": "production", 03:19:18 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:19:18 INFO - "repository": "", 03:19:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:19:18 INFO - "buildid": "20161105004017", 03:19:18 INFO - "stage_platform": "macosx64", 03:19:18 INFO - "basedir": "/builds/slave/test", 03:19:18 INFO - "nightly_build": "True", 03:19:18 INFO - "buildnumber": 16, 03:19:18 INFO - "slavename": "t-yosemite-r7-0154", 03:19:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:19:18 INFO - "platform": "yosemite_r7", 03:19:18 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:19:18 INFO - "branch": "mozilla-aurora", 03:19:18 INFO - "repo_path": "releases/mozilla-aurora", 03:19:18 INFO - "revision": "69e17427242dc8063a7ad7d739247d4c47402da5", 03:19:18 INFO - "pgo_build": "False", 03:19:18 INFO - "builduid": "ec95719e9c06458085be3ac8c3878bb2", 03:19:18 INFO - "slavebuilddir": "test" 03:19:18 INFO - } 03:19:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:19:18 INFO - Running post-action listener: _resource_record_post_action 03:19:18 INFO - [mozharness: 2016-11-05 10:19:18.128216Z] Finished read-buildbot-config step (success) 03:19:18 INFO - [mozharness: 2016-11-05 10:19:18.128330Z] Running download-and-extract step. 03:19:18 INFO - Running pre-action listener: _resource_record_pre_action 03:19:18 INFO - Running main action method: download_and_extract 03:19:18 INFO - mkdir: /builds/slave/test/build/tests 03:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:18 INFO - trying https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:19:18 INFO - Downloading https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:19:19 INFO - Downloaded 1199 bytes. 03:19:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:19:19 INFO - Using the following test package requirements: 03:19:19 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:19:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:19:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:19:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'jsshell-mac.zip'], 03:19:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:19:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:19:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:19:19 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:19:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:19:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:19:19 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:19:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:19:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:19:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:19:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:19:19 INFO - Expected file size: 16421503 03:19:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:19:27 INFO - Expected file size: 16421503 03:19:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:19:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:19:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:19:34 INFO - Expected file size: 14414089 03:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:35 INFO - trying https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:19:35 INFO - Downloading https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:19:39 INFO - Downloaded 115540949 bytes. 03:19:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:19:39 INFO - mkdir: /builds/slave/test/properties 03:19:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:39 INFO - Contents: 03:19:39 INFO - build_url:https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:19:41 INFO - Running post-action listener: _resource_record_post_action 03:19:41 INFO - Running post-action listener: set_extra_try_arguments 03:19:41 INFO - [mozharness: 2016-11-05 10:19:41.029144Z] Finished download-and-extract step (success) 03:19:41 INFO - [mozharness: 2016-11-05 10:19:41.029259Z] Running populate-webroot step. 03:19:41 INFO - Running pre-action listener: _resource_record_pre_action 03:19:41 INFO - Running main action method: populate_webroot 03:19:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:19:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:19:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:19:41 INFO - '--tppagecycles', 03:19:41 INFO - '7'], 03:19:41 INFO - 'tests': ['tsvgm']}}, 03:19:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:19:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:19:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['damp', 'tps']}, 03:19:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'tests': ['damp', 'tps']}, 03:19:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['dromaeo_dom']}, 03:19:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['basic_compositor_video']}, 03:19:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:19:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['a11yr', 03:19:41 INFO - 'ts_paint', 03:19:41 INFO - 'tpaint', 03:19:41 INFO - 'sessionrestore', 03:19:41 INFO - 'sessionrestore_no_auto_restore', 03:19:41 INFO - 'tabpaint']}, 03:19:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['tsvgx', 03:19:41 INFO - 'tsvgr_opacity', 03:19:41 INFO - 'tart', 03:19:41 INFO - 'tscrollx', 03:19:41 INFO - 'cart']}, 03:19:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:41 INFO - 'tsvgr_opacity', 03:19:41 INFO - 'tart', 03:19:41 INFO - 'tscrollx', 03:19:41 INFO - 'cart']}, 03:19:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'talos_options': ['--disable-e10s'], 03:19:41 INFO - 'tests': ['tp5o']}, 03:19:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'tests': ['tp5o']}, 03:19:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'talos_options': ['--disable-e10s', 03:19:41 INFO - '--xperf_path', 03:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:41 INFO - 'tests': ['tp5n']}, 03:19:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:41 INFO - 'talos_options': ['--xperf_path', 03:19:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:41 INFO - 'tests': ['tp5n']}}, 03:19:41 INFO - 'talos.zip': {'path': '', 03:19:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:19:41 INFO - Running post-action listener: _resource_record_post_action 03:19:41 INFO - [mozharness: 2016-11-05 10:19:41.047851Z] Finished populate-webroot step (success) 03:19:41 INFO - [mozharness: 2016-11-05 10:19:41.047983Z] Running create-virtualenv step. 03:19:41 INFO - Running pre-action listener: _resource_record_pre_action 03:19:41 INFO - Running main action method: create_virtualenv 03:19:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:19:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:41 INFO - Using real prefix '/tools/python27' 03:19:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:44 INFO - Installing pip.................done. 03:19:44 INFO - Return code: 0 03:19:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:44 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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:19:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:19:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:44 INFO - 'HOME': '/Users/cltbld', 03:19:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:44 INFO - 'LOGNAME': 'cltbld', 03:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:44 INFO - 'MOZ_NO_REMOTE': '1', 03:19:44 INFO - 'NO_EM_RESTART': '1', 03:19:44 INFO - 'PAGER': '/bin/cat', 03:19:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:44 INFO - 'PWD': '/builds/slave/test', 03:19:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:44 INFO - 'SHELL': '/bin/bash', 03:19:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:44 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:44 INFO - 'USER': 'cltbld', 03:19:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:44 INFO - 'XPC_FLAGS': '0x0', 03:19:44 INFO - 'XPC_SERVICE_NAME': '0', 03:19:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:19:44 INFO - Cleaning up... 03:19:45 INFO - Return code: 0 03:19:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:45 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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:45 INFO - 'HOME': '/Users/cltbld', 03:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:45 INFO - 'LOGNAME': 'cltbld', 03:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:45 INFO - 'MOZ_NO_REMOTE': '1', 03:19:45 INFO - 'NO_EM_RESTART': '1', 03:19:45 INFO - 'PAGER': '/bin/cat', 03:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:45 INFO - 'PWD': '/builds/slave/test', 03:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:45 INFO - 'SHELL': '/bin/bash', 03:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:45 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:45 INFO - 'USER': 'cltbld', 03:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:45 INFO - 'XPC_FLAGS': '0x0', 03:19:45 INFO - 'XPC_SERVICE_NAME': '0', 03:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:45 INFO - Downloading/unpacking psutil>=3.1.1 03:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:49 INFO - Installing collected packages: psutil 03:19:49 INFO - Running setup.py install for psutil 03:19:49 INFO - building 'psutil._psutil_osx' extension 03:19:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:19:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:19:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:19:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:19:49 INFO - building 'psutil._psutil_posix' extension 03:19:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:19:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:19:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:19:49 INFO - ^ 03:19:49 INFO - 1 warning generated. 03:19:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:49 INFO - Successfully installed psutil 03:19:49 INFO - Cleaning up... 03:19:50 INFO - Return code: 0 03:19:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:19:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:50 INFO - 'HOME': '/Users/cltbld', 03:19:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:50 INFO - 'LOGNAME': 'cltbld', 03:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:50 INFO - 'MOZ_NO_REMOTE': '1', 03:19:50 INFO - 'NO_EM_RESTART': '1', 03:19:50 INFO - 'PAGER': '/bin/cat', 03:19:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:50 INFO - 'PWD': '/builds/slave/test', 03:19:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:50 INFO - 'SHELL': '/bin/bash', 03:19:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:50 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:50 INFO - 'USER': 'cltbld', 03:19:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:50 INFO - 'XPC_FLAGS': '0x0', 03:19:50 INFO - 'XPC_SERVICE_NAME': '0', 03:19:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:52 INFO - Installing collected packages: mozsystemmonitor 03:19:52 INFO - Running setup.py install for mozsystemmonitor 03:19:53 INFO - Successfully installed mozsystemmonitor 03:19:53 INFO - Cleaning up... 03:19:53 INFO - Return code: 0 03:19:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:53 INFO - 'HOME': '/Users/cltbld', 03:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:53 INFO - 'LOGNAME': 'cltbld', 03:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:53 INFO - 'MOZ_NO_REMOTE': '1', 03:19:53 INFO - 'NO_EM_RESTART': '1', 03:19:53 INFO - 'PAGER': '/bin/cat', 03:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:53 INFO - 'PWD': '/builds/slave/test', 03:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:53 INFO - 'SHELL': '/bin/bash', 03:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:53 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:53 INFO - 'USER': 'cltbld', 03:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:53 INFO - 'XPC_FLAGS': '0x0', 03:19:53 INFO - 'XPC_SERVICE_NAME': '0', 03:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:56 INFO - warning: no files found matching '*.txt' 03:19:56 INFO - no previously-included directories found matching 'build' 03:19:56 INFO - no previously-included directories found matching 'dist' 03:19:56 INFO - no previously-included directories found matching '.git*' 03:19:56 INFO - Installing collected packages: jsonschema, functools32 03:19:56 INFO - Running setup.py install for functools32 03:19:56 INFO - warning: no files found matching '*.txt' 03:19:56 INFO - no previously-included directories found matching 'build' 03:19:56 INFO - no previously-included directories found matching 'dist' 03:19:56 INFO - no previously-included directories found matching '.git*' 03:19:56 INFO - Successfully installed jsonschema functools32 03:19:56 INFO - Cleaning up... 03:19:56 INFO - Return code: 0 03:19:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:56 INFO - 'HOME': '/Users/cltbld', 03:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:56 INFO - 'LOGNAME': 'cltbld', 03:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:56 INFO - 'MOZ_NO_REMOTE': '1', 03:19:56 INFO - 'NO_EM_RESTART': '1', 03:19:56 INFO - 'PAGER': '/bin/cat', 03:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:56 INFO - 'PWD': '/builds/slave/test', 03:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:56 INFO - 'SHELL': '/bin/bash', 03:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:56 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:56 INFO - 'USER': 'cltbld', 03:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:56 INFO - 'XPC_FLAGS': '0x0', 03:19:56 INFO - 'XPC_SERVICE_NAME': '0', 03:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:19:57 INFO - Cleaning up... 03:19:57 INFO - Return code: 0 03:19:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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', '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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:19: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:19: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 blobuploader==1.2.4 03:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:19:57 INFO - 'HOME': '/Users/cltbld', 03:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:19:57 INFO - 'LOGNAME': 'cltbld', 03:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:57 INFO - 'MOZ_NO_REMOTE': '1', 03:19:57 INFO - 'NO_EM_RESTART': '1', 03:19:57 INFO - 'PAGER': '/bin/cat', 03:19:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:57 INFO - 'PWD': '/builds/slave/test', 03:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:19:57 INFO - 'SHELL': '/bin/bash', 03:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:19:57 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:19:57 INFO - 'USER': 'cltbld', 03:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:57 INFO - 'XPC_FLAGS': '0x0', 03:19:57 INFO - 'XPC_SERVICE_NAME': '0', 03:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - Downloading docopt-0.6.1.tar.gz 03:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:01 INFO - Running setup.py install for blobuploader 03:20:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:01 INFO - Running setup.py install for requests 03:20:01 INFO - Running setup.py install for docopt 03:20:01 INFO - Successfully installed blobuploader requests docopt 03:20:01 INFO - Cleaning up... 03:20:01 INFO - Return code: 0 03:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:01 INFO - 'HOME': '/Users/cltbld', 03:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PAGER': '/bin/cat', 03:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:20:01 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - 'XPC_FLAGS': '0x0', 03:20:01 INFO - 'XPC_SERVICE_NAME': '0', 03:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-xFEtaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-XKMJNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ooJw0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-J07aAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-eeC8yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oEuZUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-CEVnxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:02 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ag_tq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-BVahTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-U8IbSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-z4r1Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-SO_XM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-wJm2p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-VE39kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-077wJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-TFPXIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:03 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Px20YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:03 INFO - Running setup.py install for manifestparser 03:20:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:04 INFO - Running setup.py install for mozcrash 03:20:04 INFO - Running setup.py install for mozdebug 03:20:04 INFO - Running setup.py install for mozdevice 03:20:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:20:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:04 INFO - Running setup.py install for mozfile 03:20:04 INFO - Running setup.py install for mozhttpd 03:20:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:04 INFO - Running setup.py install for mozinfo 03:20:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:04 INFO - Running setup.py install for mozInstall 03:20:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozleak 03:20:05 INFO - Running setup.py install for mozlog 03:20:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for moznetwork 03:20:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozprocess 03:20:05 INFO - Running setup.py install for mozprofile 03:20:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozrunner 03:20:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozscreenshot 03:20:06 INFO - Running setup.py install for moztest 03:20:06 INFO - Running setup.py install for mozversion 03:20:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:06 INFO - Cleaning up... 03:20:06 INFO - Return code: 0 03:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:06 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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:20:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:06 INFO - 'HOME': '/Users/cltbld', 03:20:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:06 INFO - 'LOGNAME': 'cltbld', 03:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:06 INFO - 'MOZ_NO_REMOTE': '1', 03:20:06 INFO - 'NO_EM_RESTART': '1', 03:20:06 INFO - 'PAGER': '/bin/cat', 03:20:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:06 INFO - 'PWD': '/builds/slave/test', 03:20:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:06 INFO - 'SHELL': '/bin/bash', 03:20:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:20:06 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:20:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:06 INFO - 'USER': 'cltbld', 03:20:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:06 INFO - 'XPC_FLAGS': '0x0', 03:20:06 INFO - 'XPC_SERVICE_NAME': '0', 03:20:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:06 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-2kU6Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:06 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oupIBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-h6CRDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-qJ4l_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:07 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)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-lhlLXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-w13SkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-l2XWwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-hzSTXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ttnePK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-EQeI0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-XTYNhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:07 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-VyWhet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:08 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)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:08 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-0CHyVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:08 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-G1rt_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:08 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-8Wn7Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:08 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-4GcwNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:08 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-tnhTqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:08 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)) 03:20:08 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)) 03:20:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20:11 INFO - Downloading blessings-1.6.tar.gz 03:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:11 INFO - Installing collected packages: blessings 03:20:11 INFO - Running setup.py install for blessings 03:20:11 INFO - Successfully installed blessings 03:20:11 INFO - Cleaning up... 03:20:11 INFO - Return code: 0 03:20:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:11 INFO - Reading from file tmpfile_stdout 03:20:11 INFO - Current package versions: 03:20:11 INFO - blessings == 1.6 03:20:11 INFO - blobuploader == 1.2.4 03:20:11 INFO - docopt == 0.6.1 03:20:11 INFO - functools32 == 3.2.3-2 03:20:11 INFO - jsonschema == 2.5.1 03:20:11 INFO - manifestparser == 1.1 03:20:11 INFO - mozInstall == 1.12 03:20:11 INFO - mozcrash == 0.17 03:20:11 INFO - mozdebug == 0.1 03:20:11 INFO - mozdevice == 0.48 03:20:11 INFO - mozfile == 1.2 03:20:11 INFO - mozhttpd == 0.7 03:20:11 INFO - mozinfo == 0.9 03:20:11 INFO - mozleak == 0.1 03:20:11 INFO - mozlog == 3.4 03:20:11 INFO - moznetwork == 0.27 03:20:11 INFO - mozprocess == 0.23 03:20:11 INFO - mozprofile == 0.28 03:20:11 INFO - mozrunner == 6.12 03:20:11 INFO - mozscreenshot == 0.1 03:20:11 INFO - mozsystemmonitor == 0.3 03:20:11 INFO - moztest == 0.7 03:20:11 INFO - mozversion == 1.4 03:20:11 INFO - psutil == 3.1.1 03:20:11 INFO - requests == 1.2.3 03:20:11 INFO - wsgiref == 0.1.2 03:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:11 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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:11 INFO - 'HOME': '/Users/cltbld', 03:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:11 INFO - 'LOGNAME': 'cltbld', 03:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:11 INFO - 'MOZ_NO_REMOTE': '1', 03:20:11 INFO - 'NO_EM_RESTART': '1', 03:20:11 INFO - 'PAGER': '/bin/cat', 03:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:11 INFO - 'PWD': '/builds/slave/test', 03:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:11 INFO - 'SHELL': '/bin/bash', 03:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:20:11 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:11 INFO - 'USER': 'cltbld', 03:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:11 INFO - 'XPC_FLAGS': '0x0', 03:20:11 INFO - 'XPC_SERVICE_NAME': '0', 03:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:12 INFO - Cleaning up... 03:20:12 INFO - Return code: 0 03:20:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:12 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 0x103440490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033b6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff77a478300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, '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.aDhY7mJCfA/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.4nakKRNYar/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:12 INFO - 'HOME': '/Users/cltbld', 03:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:12 INFO - 'LOGNAME': 'cltbld', 03:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:12 INFO - 'MOZ_NO_REMOTE': '1', 03:20:12 INFO - 'NO_EM_RESTART': '1', 03:20:12 INFO - 'PAGER': '/bin/cat', 03:20:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:12 INFO - 'PWD': '/builds/slave/test', 03:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:12 INFO - 'SHELL': '/bin/bash', 03:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:20:12 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:12 INFO - 'USER': 'cltbld', 03:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:12 INFO - 'XPC_FLAGS': '0x0', 03:20:12 INFO - 'XPC_SERVICE_NAME': '0', 03:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:12 INFO - Cleaning up... 03:20:12 INFO - Return code: 0 03:20:12 INFO - Running post-action listener: _resource_record_post_action 03:20:12 INFO - Running post-action listener: _start_resource_monitoring 03:20:12 INFO - Starting resource monitoring. 03:20:12 INFO - [mozharness: 2016-11-05 10:20:12.344054Z] Finished create-virtualenv step (success) 03:20:12 INFO - [mozharness: 2016-11-05 10:20:12.345065Z] Running install step. 03:20:12 INFO - Running pre-action listener: _resource_record_pre_action 03:20:12 INFO - Running main action method: install 03:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:12 INFO - Reading from file tmpfile_stdout 03:20:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:12 INFO - Reading from file tmpfile_stdout 03:20:12 INFO - Output received: 03:20:12 INFO - Usage: mozinstall [options] installer 03:20:12 INFO - Options: 03:20:12 INFO - -h, --help show this help message and exit 03:20:12 INFO - -d DEST, --destination=DEST 03:20:12 INFO - Directory to install application into. [default: 03:20:12 INFO - "/builds/slave/test"] 03:20:12 INFO - --app=APP Application being installed. [default: firefox] 03:20:12 INFO - mkdir: /builds/slave/test/build/application 03:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:20:44 INFO - Reading from file tmpfile_stdout 03:20:44 INFO - Output received: 03:20:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:20:44 INFO - Running post-action listener: _resource_record_post_action 03:20:44 INFO - [mozharness: 2016-11-05 10:20:44.844970Z] Finished install step (success) 03:20:44 INFO - [mozharness: 2016-11-05 10:20:44.845124Z] Running run-tests step. 03:20:44 INFO - Running pre-action listener: _resource_record_pre_action 03:20:44 INFO - Running main action method: run_tests 03:20:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:44 INFO - 2016-11-05 03:20:44.858 screenresolution[1945:17741] starting screenresolution argv=screenresolution get 03:20:44 INFO - 2016-11-05 03:20:44.860 screenresolution[1945:17741] Display 0: 1600x1200x32@60 03:20:44 INFO - 2016-11-05 03:20:44.865 screenresolution[1946:17743] starting screenresolution argv=screenresolution list 03:20:44 INFO - Available Modes on Display 0 03:20:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:20:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:20:45 INFO - Intel Iris: 03:20:45 INFO - Chipset Model: Intel Iris 03:20:45 INFO - Type: GPU 03:20:45 INFO - Bus: Built-In 03:20:45 INFO - VRAM (Dynamic, Max): 1536 MB 03:20:45 INFO - Vendor: Intel (0x8086) 03:20:45 INFO - Device ID: 0x0a2e 03:20:45 INFO - Revision ID: 0x0009 03:20:45 INFO - Displays: 03:20:45 INFO - Display: 03:20:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:20:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:20:45 INFO - Display Serial Number: 1600x1200 60 03:20:45 INFO - Main Display: Yes 03:20:45 INFO - Mirror: Off 03:20:45 INFO - Online: Yes 03:20:45 INFO - Rotation: Supported 03:20:45 INFO - Return code: 0 03:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:45 INFO - Python 2.7.3 03:20:45 INFO - Return code: 0 03:20:45 INFO - grabbing minidump binary from tooltool 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:45 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 0x103254d30>, '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 0x1030badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10324cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:20:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:20:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:20:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:45 INFO - Return code: 0 03:20:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:20:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:20:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:45 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/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:20:45 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/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:20:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDhY7mJCfA/Render', 03:20:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:45 INFO - 'HOME': '/Users/cltbld', 03:20:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:45 INFO - 'LOGNAME': 'cltbld', 03:20:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:45 INFO - 'MOZ_NO_REMOTE': '1', 03:20:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:45 INFO - 'NO_EM_RESTART': '1', 03:20:45 INFO - 'PAGER': '/bin/cat', 03:20:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:45 INFO - 'PWD': '/builds/slave/test', 03:20:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:45 INFO - 'SHELL': '/bin/bash', 03:20:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4nakKRNYar/Listeners', 03:20:45 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 03:20:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:45 INFO - 'USER': 'cltbld', 03:20:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:45 INFO - 'XPC_FLAGS': '0x0', 03:20:45 INFO - 'XPC_SERVICE_NAME': '0', 03:20:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:45 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/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:20:45 INFO - mozversion application_buildid: 20161105004017 03:20:45 INFO - mozversion application_changeset: 69e17427242dc8063a7ad7d739247d4c47402da5 03:20:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:20:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:45 INFO - mozversion application_name: Firefox 03:20:45 INFO - mozversion application_remotingname: firefox-dev 03:20:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:20:45 INFO - mozversion application_vendor: Mozilla 03:20:45 INFO - mozversion application_version: 51.0a2 03:20:45 INFO - mozversion platform_buildid: 20161105004017 03:20:45 INFO - mozversion platform_changeset: 69e17427242dc8063a7ad7d739247d4c47402da5 03:20:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:20:45 INFO - mozversion platform_version: 51.0a2 03:20:45 INFO - using testdate: 1478341245 03:20:45 INFO - actual date: 1478341245 03:20:45 INFO - starting webserver on 'localhost:49780' 03:20:45 INFO - SUITE-START | Running 2 tests 03:20:45 INFO - TEST-START | dromaeo_css 03:20:45 INFO - operating with platform_type : mac_ 03:20:45 INFO - Initialising browser for dromaeo_css test... 03:20:45 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmprQiBnU/profile http://localhost:49780/getInfo.html) 03:20:47 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 03:20:47 INFO - PROCESS | 1956 | colorDepth:24 03:20:47 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 03:20:47 INFO - PROCESS | 1956 | __metrics 03:20:48 INFO - PROCESS | 1956 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:48 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:48 INFO - TEST-INFO | 1956: exit 0 03:20:48 INFO - Browser initialized. 03:20:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:48 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmprQiBnU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:00 INFO - PROCESS | 1959 | RSS: Main: 219836416 03:21:00 INFO - PROCESS | 1959 | 03:21:51 INFO - PROCESS | 1959 | 1478341311915 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:24:03 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49780/tests/dromaeo/cssquery-ext.html) 03:24:05 INFO - PROCESS | 1959 | RSS: Main: 377163776 03:24:05 INFO - PROCESS | 1959 | 03:27:08 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-ext.html (next: http://localhost:49780/tests/dromaeo/cssquery-jquery.html) 03:27:09 INFO - PROCESS | 1959 | RSS: Main: 369410048 03:27:09 INFO - PROCESS | 1959 | 03:30:11 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49780/tests/dromaeo/cssquery-mootools.html) 03:30:12 INFO - PROCESS | 1959 | RSS: Main: 349085696 03:30:12 INFO - PROCESS | 1959 | 03:33:14 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49780/tests/dromaeo/cssquery-prototype.html) 03:33:15 INFO - PROCESS | 1959 | RSS: Main: 316329984 03:33:15 INFO - PROCESS | 1959 | 03:36:18 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49780/tests/dromaeo/cssquery-yui.html) 03:36:19 INFO - PROCESS | 1959 | RSS: Main: 310865920 03:36:19 INFO - PROCESS | 1959 | 03:39:21 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-yui.html (next: http://localhost:49780/tests/dromaeo/cssquery-dojo.html) 03:39:22 INFO - PROCESS | 1959 | RSS: Main: 486584320 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | __start_tp_report 03:39:22 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 03:39:22 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 03:39:22 INFO - PROCESS | 1959 | |i|pagename|runs| 03:39:22 INFO - PROCESS | 1959 | |0;dojo.html;3322.069820450274;3346.364190803747;3369.713574346179;3377.408953433149;3409.301093275879;5825.067989121741;5839.737211825467;5850.239468869052;5858.765649374025;5880.588358814879;5768.192453056565;5837.7373018214175;5845.298564172294;5845.912311315334;5856.443637854397;5236.423993360727;5250.31745873036;5291.523762861341;5309.654872433299;5319.148936170213;5183.663061900983;5186.844394668166;5189.948100519003;5332.466753324676;5344.251804747339;5256.684598924057;5282.471752824706;5294.470552944713;5296.947030529684;5303.814366497173;5299.894002119974;5346.545543628797;5360.0083984463;5364.383095943977;5386.434424385422;5141.177411614124;5198.090334191539;5210.687358758449;5288.233206185082;5316.9734151329385;4547.931781023287;5671.546276297886;5753.108268218432;5775.1337299405;5779.508741756956;6194.690265486708;6286.779962701284;6304.401081897213;6304.873902521924;6308.022256550196;4733.55031272032;6240.87518249637;6311.147995020659;6311.431971122621;6338.207724034496;5678.261825962681;5723.313202415737;5729.083346664514;5806.274215723035;5897.233359663259;6219.689015549295;6240.5319601030105;6271.498280137578;6279.905801412982;6287.779927702509;6236.750529978841;6238.844028899223;6246.843828904313;6250.3749625037135;6251.99968005117;6148.262208535004;6159.291681456601;6241.750329986749;6318.71565779541;6322.336154703782;6215.81352559424;6276.811695649047;6311.684415779285;6314.242290925026;6321.652309123042;6280.403361680633;6312.810615681537;6319.9368006320265;6327.715252813635;6330.873382532323;4830.8309209178215;4920.507949205051;4979.228219625964;4998.800047998112;5012.298278241049;3773;4447.6219521341045;4492.775361231991;4519.570640789186;4580.770961451981;5879.911801322984;5885.146653735184;5885.911711324334;5888.676122813286;5896.174535565025;6282.654454005074;6292.182016337847;6304.18045654062;6304.243490781136;6308.274548426898;5690.317161940594;5725.971370143206;5779.24869766936;5782.826515204551;5839.0949402842625;5472.179173123984;5483.122700367922;5489.945100549024;5494.670319780826;5498.835034948878;6295.905561416491;6310.558260921784;6312.905306420407;6315.400036996478;6320.27316858558;6202.56582039271;6248.312685604489;6266.467350275278;6319.936800631935;6326.082718005955;6213.65824879636;6242.282137554058;6260.530460215411;6309.716062777278;6314.810555683337;6252.499800016079;6264.404881536247;6276.215473065867;6278.121063051268;6285.308616052139;6103.603265787887;6157.53818463626;6234.220722409699;6266.624002559861;6295.842603934938;6015.368386319374;6034.064719968412;6036.275646922398;6115.113308570321;6139.093519790236;6141.63943600049;6142.324344322032;6147.170132032118;6157.6613286269685;6184.165137706532;5952.226210592596;5990.460858522754;6008.7296071676;6013;6015.819525414245;5962.582619216613;6034.78878239277;6061.878762424639;6096.786612468542;6097.420745029215;5998.9100163496705;6000.489958353589;6017.06735456005;6039.6678182698615;6079.817605471843 03:39:22 INFO - PROCESS | 1959 | |1;ext.html;461.17679941304766;474.79346484279364;497.9153543897537;511.6929842094744;532.5739408473222;30385.24036899076;38350;40783.59216407835;40852.795736021275;41683.74948751542;42959.14081718364;43116.35325470121;43232.56767432325;43258;43381.566184338146;9650.999999999982;9823.754406139868;9836.458994755285;9846.458444785534;9914.652987145451;8737.038925718198;8964.238039766627;11919.40402979852;12150.574729884456;12164.02687784975;12024.819627705592;12034.33811140387;12044.397780111003;12063.095267854902;12078;8638.09300023501;12090.516379344816;12145.149839511238;12152.392380380945;12180.573679921205;7673.884891726629;11582.247153934968;11920.165588408814;11946.984506316974;12207.450664720109;41253;41612.58387416117;41628.1674366514;41644.37533437001;41695.374569381485;3391.5421418108485;3570.0539357070397;3622.873199438007;3975.463312452811;4023.8189281482405;29750.85124574385;29967.400651986838;31551.89568365096;32487.86292479752;32497;3159.3207460395897;3181.96818031819;3254.267789747288;3330.7834990725523;3367.764256502046;533615;543126;543946;546406;546487.2675636637;61656.69171654113;62033.689831551455;62048.68975655183;62101;62204.37795621986;34652;34809.65190348115;34867.65132348695;37075.258494829955;65133;16652.83347166537;16779.91610041942;16790.496285111465;16815.495535133967;16841.831581684026;11964.82052769209;12349.691257718629;13203.603891883258;13293.268870212038;13317;16436.589085272964;18910.338138165374;19113.522161945784;20049.742105550715;20150.09324580368;7886.411682684365;7949.920500794918;7971.003624546932;7989.640466178919;8098.704207326799;878.8901387326584;1007.8992100790009;1065.5577935156978;1089.4171618184391;1100.7743412600398;30186.396272074435;30279.545806812916;30480.171189728688;30813.537796933066;30830.84584577063;1083.0739717541546;1095.9890401095886;1138.2089447833841;1166.1487114406361;1188.2276520261898;15217.6195595111;15626.531204063896;15733.44932927365;15976.360945562048;16113.838861611233;725517;730363;731665;732006;734474;58803.41196588065;59118.70440647769;59189.704051479464;59471;59530.404695952486;1266.1896386312767;1281.9935900320252;1318.6241921052647;1370.164199838078;1400.0969374753226;29429.96995105161;31318;31367.372652546364;31409.685903140675;32158.67841321557;49191.754041229564;49829.50170498249;49870;49883;49913.75043124761;540312;543481;543514;545354;546623;22775;26870;26952.056678016175;26980.73019269782;28254.85872570624;48045;48218.75890620524;48397.27404088871;48709.269360958904;48935;38320;39053.609463906134;39333.26333998266;40855.59144408518;41220.1755964873;37464.68873589411;37470;38325.61674383221;39789;39907.80276591707;38092.80953595214;38321.04197395087;38415.23169536649;38596.42105368478;38602;31023.914163004185;33566.664333356355;34930;35597.64402356047;36222.91331260066;25512.107076252243;25735.613965790904;25876;26153.60769588496;26302.34244143835 03:39:22 INFO - PROCESS | 1959 | |2;jquery.html;344.6897791987211;350.9052555809933;358.9554396705586;364.69001348853476;366.69197873786015;14960.775588366183;15104.848951510496;16178.19109044546;17525.298988040497;20970.37088887332;19708.802911970877;19915.904625245606;19998.50003749907;20314;20573.382798516068;4548.704334218265;5426.131818908985;5695.430456954313;5708.1152421374545;5899.144624029514;5612.130119831412;5783.392743761908;6149;6190.442860142586;6210.968945155268;6134.539909506782;6139.8772024559485;6141.017437210047;6147.815565533019;6150.538709596775;5795.101759227306;6069.787557435468;6145.661988590626;6187.381261873822;6191.349908259613;5781.971090144564;5970.223870896799;6006.759729610811;6032.607880487798;6039.124326972608;11315.207935444521;13200.603981880558;13414.86585134146;13512.662183445394;20622.58754824895;2255.4474153832252;2367.905283788664;2522.230719630512;2844.928876778097;2999.505081661545;9412.717618471457;10009.499525023792;10465.79068418635;10500.212484063726;10519.368837869752;1874.250299880059;1909.4176276235742;1999.2602736987262;2001.1795163982842;2068.834493240537;80461;94019.52990235074;114354.99999999917;126445.01278772323;137802.999999999;11645.941770291263;11650.30098194111;11761.05911527093;11808.46861891217;11934.3436111013;12825.23048617086;14669.48656797007;14825.62935926589;14864.513548645265;14866.033707808958;8557.657693692183;8676.566171691517;8703.086175951561;8712.869306960401;8836.779080523038;8646.956765216133;8655.307575393954;8674.436161649473;8792.60433280504;8820.073892241351;3902.3951287550476;4404.515503294635;4556.863294101182;4578.702384345073;4596.540345965377;1898.6392585408728;1975.5851271233203;1983.1670698306746;1993.1927569334443;1993.8504612154147;727.4689476682051;881.9559022048871;929.4098247612815;963.7253382785873;988.2143695761887;19594.412167634993;20739.58520829575;20785.58428831415;20980.05589748465;21314.934253287272;925.5233554719325;935.3078721745995;974.5161049248964;976.9560369783377;993.2203220471895;9163.633454661738;10318.43248621333;10967.122630189566;10978.176636752276;10981.835272470918;601124;603077;612548;613133;613159;106911;128223;132754.33622831825;135784;141679.5832041687;863.2144748279161;883.2580632268925;965.7826988927435;966.1353088985319;968.1480297338297;16369;16407.753883691516;18047.09764511743;18820.435386937865;18925.810741892954;56694.14958775539;57142;58262.708686456295;59733.10400344085;59751;73238.26761732314;73437;76989;80145.79781303402;80745;7276.636168191675;7958.920410795818;7971.1630278819885;8162.83674326522;8472.279856212292;10758.515866785858;12364.381780911099;13213.933930330288;13375.598732038054;13491.123076999964;6315.55791094619;11272.605458808903;11700.590479333523;11818.881811182122;11881.762364752829;11035.834462482908;11288.322700637988;11336;11478.540858365572;11844.70388240301;5803.390643982321;8526.872096918427;9519.857202141835;11191.832122518332;11535.36555489456;8234.464759790595;8281.29608983219;8356.87464688018;8428.072911979554;8508.276796472122;10825.945870270598;11055.83416248773;11334.093272538343;11635.650930472098;11764.529418823151 03:39:22 INFO - PROCESS | 1959 | |3;mootools.html;1526.1834918318698;1553.7125631758126;1586.4050980882168;1724.120698443794;1865.6455273498025;8481.575921203937;9052.366334356597;9052.95473522633;9058.864117038249;9065.093490650948;7826.1391246962785;8166.959165204181;8186.631601577928;8256.422050456455;8270.875936860937;2145.5065334972965;2346.3195673254736;2424.2242482405636;2424.6726691896633;2435.2937648082034;2404.987975060131;2410;2430.586800243963;2431.7932975697;2434.987825060872;2423.4183795889035;2425.4300239443714;2428.1865575032384;2428.720697119836;2429.671994280767;2380.940476488084;2418.5404773093146;2419.709634843812;2426.3085020768995;2426.3206302235403;2395.0060724799187;2403.230966090852;2421.987890060556;2423.5031818477346;2425.4421483058995;8867.68963086289;8888.822223555493;8968.865467018;8980.012198658142;8994.820103597956;5247.055530004598;5384.246205531229;5392.946070539323;5400.081986062379;5408.242846001563;3533.3463309287863;3557.181848174934;3607.6572725591027;3687.3547129252274;3688.483612294281;1082.8105081610686;1090.5528733219421;1091.9454027298602;1108.130117857478;1110.3781882146025;11663.941680291544;11683.065354771683;11810.350430726307;11833.290002599872;11863.881361186364;4645.001324715135;4703.882402939886;4868.367112275381;4882.389701287339;4895.485973972753;10035.849462258071;10074.546645400975;10075.848862267072;10077.546510406903;10096.091351778376;5368.516833485005;5377.569794416516;5387.784488620411;5395.62230643859;5397.676139431646;4278.828846846091;4776.355192049029;4908.852734417973;4945.307656928033;4961.305417241589;3494.4408894577255;3964.7224694271126;3982.7809470478824;3994.78028708418;4085.6731461483605;1287.587971849018;1294.786360250567;1301.7982212757038;1309.8166256724066;1321.431784332727;763.3549650545281;870.8650159225331;897.8787863638325;923.4874644572193;927.4852456886492;5823.650580965155;5902.61632993854;5970.58205925581;6017.007193812972;6087.995480745627;821.3962737388015;903.9141281578239;920.8987011428737;979.4123525884412;996.8155891160159;3843.3082045231567;4018.7789671568344;4041.8989525262105;4077.959220407817;4162.875113746592;10683.14534837211;10896.673099807018;11013.559457621606;11019.944900275448;11031.724206894893;10960.780784384267;10975.560977560808;10977.28647637901;10978.670639880816;11006;8189.631466583899;8273.958630206931;8336.499810011297;8337.583120843934;8340.37447191463;4821.566059054702;4938.950610493993;5936.465718085393;6046.758129674764;6049.758009679564;10044.146247569039;10128.189744820544;10296.382217067;10324.122449591869;10380.42907640057;9870.358426702242;10235.334703244265;10429.739256518647;10515.05364517197;10533.9473302633;6668.866622667422;6888.758893438706;6899.344562266577;7015.228324884157;7136.571805691675;8562.957185214034;8603.698870539502;8657.826843463221;8677;8677.1756683115;7665.348445382205;7696.114946781192;7698.846023079619;7735.381169506539;7824.765257042298;7342.449316301192;7495.138059123271;7577.5453472791805;7619.542827430372;7622.123455802654;7027.6837542309695;7151.681810935806;7215.314545118205;7219.2780721929485;7225.313595208447;4941.925871111865;4986.252062190701;5087.618428617942;5149.124648809637;5217.8173763918085;5027.824026159067;5030.421501527371;5191.065608190562;5240.161574148118;5328.440513746001 03:39:22 INFO - PROCESS | 1959 | |4;prototype.html;248.78355830427532;288.4274714691337;294.880573367786;298.5000124790975;308.78847989127433;4637.930431043537;5300.6819590824525;5392.43379445158;5441.156620723789;5503.624093976506;4860;5145.742712864351;5295.31160949077;5376.758045887935;5469.507744303012;3367.8147701876323;3478.286951175003;4052.7973601319964;4110.424540564323;4115.670746340301;4087.608748881893;4087.713860029799;4094.9385759213637;4095.0548489467565;4140.441040459529;3422.5550678411896;3431.6053653829754;3471.375152472554;3966.52401711795;4057.918841623166;3303.1832492129474;4065;4072.6945479089186;4085.387191921206;4242.136557823473;3190.3778763141195;3298.6805277889034;3319.983400082984;3444.3111377724554;3556.715462762973;5166.250893620404;5173.715445650488;5218.321618189649;5219.530242278213;5226.477352264743;4302.698811083225;4543.8182472701055;4595.7702114894455;4631.583157515806;4691.202495575761;4966.573064585425;4998.7250701211415;5234.947650523484;5649.858753531194;5670.432956704338;3440.690337869604;3870.1679138984973;3878.728489005771;3897.590752970954;3898.9220215595815;5031.572316353151;5218.990688584884;5715.457031581993;5800.709096769369;5983.730732117066;3522.9295414091575;3703.8888833334504;3851.768893866377;3936.0946982194255;3944.9211015779524;3397.9660203398143;3427.3488037272837;3524.7708898922;3924.5290565131795;3938.6455219030427;4183.811728472226;4219.599138081878;4585.564371384713;4622.953770462253;4665.790039448233;4971.751412429364;5174.741262936914;5712.542996560265;5725.570582206351;5761.308642962787;1158.779831831966;1246.429498831479;1351.3986276107235;1358.4566173530666;1359.4358341288255;835.8035861572525;861.8836457078339;873.3711627814081;940.1820416237916;961.9230461563059;5116.974415127975;5369.228154708937;5449.174526533577;5461.863453413617;5470.9452905471235;5684.37471878093;5809.3609702932645;5837.036888913367;5921.822345329647;5947.702614869239;4634.582887540138;5096.388433388017;5275.841724748264;5289.074411977888;5411.648242864201;2800.943981120366;2819.631509532003;2884.5817356483194;2955.748761355309;2986.9694955240407;5110.718910459886;5631.070873305941;5767.653940763567;5922.911156332659;5932.40675932412;5833.854153646108;5842.298924129047;5879.2944846618675;5936.5547583931375;5975.731092100866;5837.832433513315;5873.559483038704;5908.852278692981;5922.378150294329;6000.5799594028;5042.319286896369;5601.04782187021;5705.857353566028;5829.65917838891;5897.734601943009;5333.146696528537;5697.800576979786;5732.942670573408;5738.9913530264075;5748.770049198152;4774.021325628308;5294.682319060868;5853.0635098384055;5896.611872191769;5946.840366128564;3350.463925771865;3494.5981212160927;3848.6138594071854;3885.475460812754;3945.427912952663;4818.445878723852;5350.545203657577;5575.470330318613;5591.077472217039;5932.436418540232;5239.214117882349;5548.2549279235545;5553.194786755978;5827.533797296291;5835.124731290341;5715.571332150189;5730.570207234391;5732.656040637575;5753.942460575341;5766.163906233656;5380.515753582196;5549.306336707911;5623.862932085781;5652.604317697722;5674.319081710221;5153.896922061613;5559.444055594408;5613.073842816053;5646.576506761927;5650;4381.304304404325;5527.462424048693;5538.756803494591;5616.85957851057;5622.353429355677 03:39:22 INFO - PROCESS | 1959 | |5;yui.html;633.7465013994401;781.238292664652;803.5459965119709;808.2483290539803;811.6428771340613;15194.620134496628;15863;16538.586535336606;16543.17284135793;16722.66554668906;13374.933125334359;13716.588502344946;13716.862831371684;13732.519361822338;13766.724665506685;677.7187467201105;845.1168528887312;867.5488745852153;869.0527325215514;869.9086595907434;706.7561691216522;714.6676795290189;839.2614499240659;862.8446879561676;863.995680021599;915.0483497162976;920.2499962530517;921.7280902133853;922.6401703335705;922.6862866625346;913.0139449394671;914.3553794574875;915.5285028210477;916.7020718266523;918.554501066982;534.625761966621;550.435803301615;656.9671516424207;672.653583404547;679.300320669711;15542;15609.92195039029;15618.843811561852;15621.062736235748;15624.296906639229;13914.582562523039;14183.716325673531;14263.857361426357;14330;14446.783298250535;12214.57248996281;12511.249325040526;12546.121771476;12940.288284144368;13224.471021159143;4469.776511174428;4485.798139083749;4510.233260345716;4568.725876447391;4589.449266088058;120835;124953;127568;128929.35535322357;132185.3562928736;10903.29128606638;11029.669109926715;11263.493142808593;11269.830952535718;11295.830562541569;22329.888350558143;22420.43948901258;22457.887710561343;22470.10119595198;22475.775242247695;8092.583712938478;8106;8200.220979006985;8263.214994575506;8324.6670133194;3841.692664586826;4407.537208593051;4520.773961301922;4541.568550987651;4721.244600863845;3492.7729697570085;3636.054625797312;3639.836207370675;3640.563132424073;3652.36083685354;623.5167744997663;624.2883113250898;624.6408315218677;630.9242890853127;639.3670266436195;521.7000224870638;534.3027349309111;545.4736179586718;615.4553220399889;650.3691419323249;9040.276777857756;9269.72190834276;9358.906410935804;9409.905900940903;9578.185854202331;605.3734384911595;630.6027202862167;634.9587276827084;642.3608509532951;645.7998020613625;4390.980742099689;4457.598816106566;4503.437070366204;4514.367988481616;4617.238155704271;106893;106911;109841;156433;168218;110025;118591;122067;141883;142208;109371;118904.8657080578;119136.8086319143;122470;125914.37042814911;8561.61472733741;8739.650413983623;8740.956295218737;8815.559222039;8911.37620366568;60096.39903600908;61264.46838829065;64832.67583662052;64866;65630.67184664046;88650.22699546102;88817.55591222002;95486.52256738672;100062;101299;13019.674508137372;13202.603921882359;13270.734585308433;13505.662358441117;13804.723905522034;12586.685332866751;13118.475260989453;15180.208914759607;15619.609509761893;16127.77987934763;13814.585562433143;14451.988360814643;14520.201388923711;15098.622534436727;15113.942024058211;11156.721081973015;13937.024408291321;14003.299835008413;14037.5086871959;14377.7843332348;13410.865891341353;13920.164790112625;13963.232022238875;14072.552224705012;14832.7775083376;10831.962514331415;11159.27464714791;11361.943190283995;11849.703757406134;11918.880811191777;9862.802743945225;11117.27737697047;11267.211295209258;11381.886181138083;11640.243384180001 03:39:22 INFO - PROCESS | 1959 | __end_tp_report 03:39:22 INFO - PROCESS | 1959 | __start_cc_report 03:39:22 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1498 03:39:22 INFO - PROCESS | 1959 | __end_cc_report 03:39:22 INFO - PROCESS | 1959 | __startTimestamp1478342362212__endTimestamp 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | ------- Summary: start ------- 03:39:22 INFO - PROCESS | 1959 | Number of tests: 6 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5779.04 Median:6013.00 stddev:655.55 (10.9%) stddev-sans-first:628.59 03:39:22 INFO - PROCESS | 1959 | Values: 3322.1 3346.4 3369.7 3377.4 3409.3 5825.1 5839.7 5850.2 5858.8 5880.6 5768.2 5837.7 5845.3 5845.9 5856.4 5236.4 5250.3 5291.5 5309.7 5319.1 5183.7 5186.8 5189.9 5332.5 5344.3 5256.7 5282.5 5294.5 5296.9 5303.8 5299.9 5346.5 5360.0 5364.4 5386.4 5141.2 5198.1 5210.7 5288.2 5317.0 4547.9 5671.5 5753.1 5775.1 5779.5 6194.7 6286.8 6304.4 6304.9 6308.0 4733.6 6240.9 6311.1 6311.4 6338.2 5678.3 5723.3 5729.1 5806.3 5897.2 6219.7 6240.5 6271.5 6279.9 6287.8 6236.8 6238.8 6246.8 6250.4 6252.0 6148.3 6159.3 6241.8 6318.7 6322.3 6215.8 6276.8 6311.7 6314.2 6321.7 6280.4 6312.8 6319.9 6327.7 6330.9 4830.8 4920.5 4979.2 4998.8 5012.3 3773.0 4447.6 4492.8 4519.6 4580.8 5879.9 5885.1 5885.9 5888.7 5896.2 6282.7 6292.2 6304.2 6304.2 6308.3 5690.3 5726.0 5779.2 5782.8 5839.1 5472.2 5483.1 5489.9 5494.7 5498.8 6295.9 6310.6 6312.9 6315.4 6320.3 6202.6 6248.3 6266.5 6319.9 6326.1 6213.7 6242.3 6260.5 6309.7 6314.8 6252.5 6264.4 6276.2 6278.1 6285.3 6103.6 6157.5 6234.2 6266.6 6295.8 6015.4 6034.1 6036.3 6115.1 6139.1 6141.6 6142.3 6147.2 6157.7 6184.2 5952.2 5990.5 6008.7 6013.0 6015.8 5962.6 6034.8 6061.9 6096.8 6097.4 5998.9 6000.5 6017.1 6039.7 6079.8 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:73218.30 Median:19922.89 stddev:163950.02 (822.9%) stddev-sans-first:164318.93 03:39:22 INFO - PROCESS | 1959 | Values: 461.2 474.8 497.9 511.7 532.6 30385.2 38350.0 40783.6 40852.8 41683.7 42959.1 43116.4 43232.6 43258.0 43381.6 9651.0 9823.8 9836.5 9846.5 9914.7 8737.0 8964.2 11919.4 12150.6 12164.0 12024.8 12034.3 12044.4 12063.1 12078.0 8638.1 12090.5 12145.1 12152.4 12180.6 7673.9 11582.2 11920.2 11947.0 12207.5 41253.0 41612.6 41628.2 41644.4 41695.4 3391.5 3570.1 3622.9 3975.5 4023.8 29750.9 29967.4 31551.9 32487.9 32497.0 3159.3 3182.0 3254.3 3330.8 3367.8 533615.0 543126.0 543946.0 546406.0 546487.3 61656.7 62033.7 62048.7 62101.0 62204.4 34652.0 34809.7 34867.7 37075.3 65133.0 16652.8 16779.9 16790.5 16815.5 16841.8 11964.8 12349.7 13203.6 13293.3 13317.0 16436.6 18910.3 19113.5 20049.7 20150.1 7886.4 7949.9 7971.0 7989.6 8098.7 878.9 1007.9 1065.6 1089.4 1100.8 30186.4 30279.5 30480.2 30813.5 30830.8 1083.1 1096.0 1138.2 1166.1 1188.2 15217.6 15626.5 15733.4 15976.4 16113.8 725517.0 730363.0 731665.0 732006.0 734474.0 58803.4 59118.7 59189.7 59471.0 59530.4 1266.2 1282.0 1318.6 1370.2 1400.1 29430.0 31318.0 31367.4 31409.7 32158.7 49191.8 49829.5 49870.0 49883.0 49913.8 540312.0 543481.0 543514.0 545354.0 546623.0 22775.0 26870.0 26952.1 26980.7 28254.9 48045.0 48218.8 48397.3 48709.3 48935.0 38320.0 39053.6 39333.3 40855.6 41220.2 37464.7 37470.0 38325.6 39789.0 39907.8 38092.8 38321.0 38415.2 38596.4 38602.0 31023.9 33566.7 34930.0 35597.6 36222.9 25512.1 25735.6 25876.0 26153.6 26302.3 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:34804.40 Median:365.69 stddev:101520.64 (27761.3%) stddev-sans-first:101772.46 03:39:22 INFO - PROCESS | 1959 | Values: 344.7 350.9 359.0 364.7 366.7 14960.8 15104.8 16178.2 17525.3 20970.4 19708.8 19915.9 19998.5 20314.0 20573.4 4548.7 5426.1 5695.4 5708.1 5899.1 5612.1 5783.4 6149.0 6190.4 6211.0 6134.5 6139.9 6141.0 6147.8 6150.5 5795.1 6069.8 6145.7 6187.4 6191.3 5782.0 5970.2 6006.8 6032.6 6039.1 11315.2 13200.6 13414.9 13512.7 20622.6 2255.4 2367.9 2522.2 2844.9 2999.5 9412.7 10009.5 10465.8 10500.2 10519.4 1874.3 1909.4 1999.3 2001.2 2068.8 80461.0 94019.5 114355.0 126445.0 137803.0 11645.9 11650.3 11761.1 11808.5 11934.3 12825.2 14669.5 14825.6 14864.5 14866.0 8557.7 8676.6 8703.1 8712.9 8836.8 8647.0 8655.3 8674.4 8792.6 8820.1 3902.4 4404.5 4556.9 4578.7 4596.5 1898.6 1975.6 1983.2 1993.2 1993.9 727.5 882.0 929.4 963.7 988.2 19594.4 20739.6 20785.6 20980.1 21314.9 925.5 935.3 974.5 977.0 993.2 9163.6 10318.4 10967.1 10978.2 10981.8 601124.0 603077.0 612548.0 613133.0 613159.0 106911.0 128223.0 132754.3 135784.0 141679.6 863.2 883.3 965.8 966.1 968.1 16369.0 16407.8 18047.1 18820.4 18925.8 56694.1 57142.0 58262.7 59733.1 59751.0 73238.3 73437.0 76989.0 80145.8 80745.0 7276.6 7958.9 7971.2 8162.8 8472.3 10758.5 12364.4 13213.9 13375.6 13491.1 6315.6 11272.6 11700.6 11818.9 11881.8 11035.8 11288.3 11336.0 11478.5 11844.7 5803.4 8526.9 9519.9 11191.8 11535.4 8234.5 8281.3 8356.9 8428.1 8508.3 10825.9 11055.8 11334.1 11635.7 11764.5 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5781.13 Median:4888.94 stddev:3246.11 (66.4%) stddev-sans-first:3239.47 03:39:22 INFO - PROCESS | 1959 | Values: 1526.2 1553.7 1586.4 1724.1 1865.6 8481.6 9052.4 9053.0 9058.9 9065.1 7826.1 8167.0 8186.6 8256.4 8270.9 2145.5 2346.3 2424.2 2424.7 2435.3 2405.0 2410.0 2430.6 2431.8 2435.0 2423.4 2425.4 2428.2 2428.7 2429.7 2380.9 2418.5 2419.7 2426.3 2426.3 2395.0 2403.2 2422.0 2423.5 2425.4 8867.7 8888.8 8968.9 8980.0 8994.8 5247.1 5384.2 5392.9 5400.1 5408.2 3533.3 3557.2 3607.7 3687.4 3688.5 1082.8 1090.6 1091.9 1108.1 1110.4 11663.9 11683.1 11810.4 11833.3 11863.9 4645.0 4703.9 4868.4 4882.4 4895.5 10035.8 10074.5 10075.8 10077.5 10096.1 5368.5 5377.6 5387.8 5395.6 5397.7 4278.8 4776.4 4908.9 4945.3 4961.3 3494.4 3964.7 3982.8 3994.8 4085.7 1287.6 1294.8 1301.8 1309.8 1321.4 763.4 870.9 897.9 923.5 927.5 5823.7 5902.6 5970.6 6017.0 6088.0 821.4 903.9 920.9 979.4 996.8 3843.3 4018.8 4041.9 4078.0 4162.9 10683.1 10896.7 11013.6 11019.9 11031.7 10960.8 10975.6 10977.3 10978.7 11006.0 8189.6 8274.0 8336.5 8337.6 8340.4 4821.6 4939.0 5936.5 6046.8 6049.8 10044.1 10128.2 10296.4 10324.1 10380.4 9870.4 10235.3 10429.7 10515.1 10533.9 6668.9 6888.8 6899.3 7015.2 7136.6 8563.0 8603.7 8657.8 8677.0 8677.2 7665.3 7696.1 7698.8 7735.4 7824.8 7342.4 7495.1 7577.5 7619.5 7622.1 7027.7 7151.7 7215.3 7219.3 7225.3 4941.9 4986.3 5087.6 5149.1 5217.8 5027.8 5030.4 5191.1 5240.2 5328.4 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4558.73 Median:5219.26 stddev:1433.54 (27.5%) stddev-sans-first:1400.59 03:39:22 INFO - PROCESS | 1959 | Values: 248.8 288.4 294.9 298.5 308.8 4637.9 5300.7 5392.4 5441.2 5503.6 4860.0 5145.7 5295.3 5376.8 5469.5 3367.8 3478.3 4052.8 4110.4 4115.7 4087.6 4087.7 4094.9 4095.1 4140.4 3422.6 3431.6 3471.4 3966.5 4057.9 3303.2 4065.0 4072.7 4085.4 4242.1 3190.4 3298.7 3320.0 3444.3 3556.7 5166.3 5173.7 5218.3 5219.5 5226.5 4302.7 4543.8 4595.8 4631.6 4691.2 4966.6 4998.7 5234.9 5649.9 5670.4 3440.7 3870.2 3878.7 3897.6 3898.9 5031.6 5219.0 5715.5 5800.7 5983.7 3522.9 3703.9 3851.8 3936.1 3944.9 3398.0 3427.3 3524.8 3924.5 3938.6 4183.8 4219.6 4585.6 4623.0 4665.8 4971.8 5174.7 5712.5 5725.6 5761.3 1158.8 1246.4 1351.4 1358.5 1359.4 835.8 861.9 873.4 940.2 961.9 5117.0 5369.2 5449.2 5461.9 5470.9 5684.4 5809.4 5837.0 5921.8 5947.7 4634.6 5096.4 5275.8 5289.1 5411.6 2800.9 2819.6 2884.6 2955.7 2987.0 5110.7 5631.1 5767.7 5922.9 5932.4 5833.9 5842.3 5879.3 5936.6 5975.7 5837.8 5873.6 5908.9 5922.4 6000.6 5042.3 5601.0 5705.9 5829.7 5897.7 5333.1 5697.8 5732.9 5739.0 5748.8 4774.0 5294.7 5853.1 5896.6 5946.8 3350.5 3494.6 3848.6 3885.5 3945.4 4818.4 5350.5 5575.5 5591.1 5932.4 5239.2 5548.3 5553.2 5827.5 5835.1 5715.6 5730.6 5732.7 5753.9 5766.2 5380.5 5549.3 5623.9 5652.6 5674.3 5153.9 5559.4 5613.1 5646.6 5650.0 4381.3 5527.5 5538.8 5616.9 5622.4 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:25258.74 Median:12984.27 stddev:40068.67 (308.6%) stddev-sans-first:40138.42 03:39:22 INFO - PROCESS | 1959 | Values: 633.7 781.2 803.5 808.2 811.6 15194.6 15863.0 16538.6 16543.2 16722.7 13374.9 13716.6 13716.9 13732.5 13766.7 677.7 845.1 867.5 869.1 869.9 706.8 714.7 839.3 862.8 864.0 915.0 920.2 921.7 922.6 922.7 913.0 914.4 915.5 916.7 918.6 534.6 550.4 657.0 672.7 679.3 15542.0 15609.9 15618.8 15621.1 15624.3 13914.6 14183.7 14263.9 14330.0 14446.8 12214.6 12511.2 12546.1 12940.3 13224.5 4469.8 4485.8 4510.2 4568.7 4589.4 120835.0 124953.0 127568.0 128929.4 132185.4 10903.3 11029.7 11263.5 11269.8 11295.8 22329.9 22420.4 22457.9 22470.1 22475.8 8092.6 8106.0 8200.2 8263.2 8324.7 3841.7 4407.5 4520.8 4541.6 4721.2 3492.8 3636.1 3639.8 3640.6 3652.4 623.5 624.3 624.6 630.9 639.4 521.7 534.3 545.5 615.5 650.4 9040.3 9269.7 9358.9 9409.9 9578.2 605.4 630.6 635.0 642.4 645.8 4391.0 4457.6 4503.4 4514.4 4617.2 106893.0 106911.0 109841.0 156433.0 168218.0 110025.0 118591.0 122067.0 141883.0 142208.0 109371.0 118904.9 119136.8 122470.0 125914.4 8561.6 8739.7 8741.0 8815.6 8911.4 60096.4 61264.5 64832.7 64866.0 65630.7 88650.2 88817.6 95486.5 100062.0 101299.0 13019.7 13202.6 13270.7 13505.7 13804.7 12586.7 13118.5 15180.2 15619.6 16127.8 13814.6 14452.0 14520.2 15098.6 15113.9 11156.7 13937.0 14003.3 14037.5 14377.8 13410.9 13920.2 13963.2 14072.6 14832.8 10832.0 11159.3 11361.9 11849.7 11918.9 9862.8 11117.3 11267.2 11381.9 11640.2 03:39:22 INFO - PROCESS | 1959 | -------- Summary: end -------- 03:39:22 INFO - PROCESS | 1959 | 03:39:22 INFO - TEST-INFO | 1959: exit 0 03:39:22 INFO - TEST-OK | dromaeo_css | took 1117477ms 03:39:22 INFO - TEST-START | kraken 03:39:22 INFO - operating with platform_type : mac_ 03:39:22 INFO - Initialising browser for kraken test... 03:39:22 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpIGmK1L/profile http://localhost:49780/getInfo.html) 03:39:25 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 03:39:25 INFO - PROCESS | 1985 | colorDepth:24 03:39:25 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 03:39:25 INFO - PROCESS | 1985 | __metrics 03:39:25 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:39:25 INFO - PROCESS | 1985 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:26 INFO - TEST-INFO | 1985: exit 0 03:39:26 INFO - Browser initialized. 03:39:26 INFO - Running cycle 1/1 for kraken test... 03:39:26 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpIGmK1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:38 INFO - PROCESS | 1987 | RSS: Main: 219369472 03:39:38 INFO - PROCESS | 1987 | 03:39:41 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:41 INFO - PROCESS | 1987 | RSS: Main: 269668352 03:39:41 INFO - PROCESS | 1987 | 03:39:44 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-dft) 03:39:45 INFO - PROCESS | 1987 | RSS: Main: 280199168 03:39:45 INFO - PROCESS | 1987 | 03:39:48 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-fft) 03:39:48 INFO - PROCESS | 1987 | RSS: Main: 377876480 03:39:48 INFO - PROCESS | 1987 | 03:39:50 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-oscillator) 03:39:51 INFO - PROCESS | 1987 | RSS: Main: 280256512 03:39:51 INFO - PROCESS | 1987 | 03:39:53 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:54 INFO - PROCESS | 1987 | RSS: Main: 281194496 03:39:54 INFO - PROCESS | 1987 | 03:39:57 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:57 INFO - PROCESS | 1987 | RSS: Main: 318849024 03:39:57 INFO - PROCESS | 1987 | 03:40:00 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:01 INFO - PROCESS | 1987 | RSS: Main: 318607360 03:40:01 INFO - PROCESS | 1987 | 03:40:03 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49780/tests/kraken/driver.html?testName=json-parse-financial) 03:40:04 INFO - PROCESS | 1987 | RSS: Main: 314765312 03:40:04 INFO - PROCESS | 1987 | 03:40:06 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:06 INFO - PROCESS | 1987 | RSS: Main: 291106816 03:40:06 INFO - PROCESS | 1987 | 03:40:08 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:09 INFO - PROCESS | 1987 | RSS: Main: 294199296 03:40:09 INFO - PROCESS | 1987 | 03:40:11 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:11 INFO - PROCESS | 1987 | RSS: Main: 298057728 03:40:11 INFO - PROCESS | 1987 | 03:40:14 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:15 INFO - PROCESS | 1987 | RSS: Main: 310411264 03:40:15 INFO - PROCESS | 1987 | 03:40:18 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:19 INFO - PROCESS | 1987 | RSS: Main: 310173696 03:40:19 INFO - PROCESS | 1987 | 03:40:20 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49780/tests/kraken/driver.html?testName=ai-astar) 03:40:21 INFO - PROCESS | 1987 | RSS: Main: 353824768 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | __start_tp_report 03:40:21 INFO - PROCESS | 1987 | _x_x_mozilla_page_load 03:40:21 INFO - PROCESS | 1987 | _x_x_mozilla_page_load_details 03:40:21 INFO - PROCESS | 1987 | |i|pagename|runs| 03:40:21 INFO - PROCESS | 1987 | |0;ai-astar;115;114;114;114;114;115;114;114;113;115 03:40:21 INFO - PROCESS | 1987 | |1;audio-beat-detection;144;134;132;140;109;109;108;106;143;132 03:40:21 INFO - PROCESS | 1987 | |2;audio-dft;185;184;184;187;182;182;185;184;185;185 03:40:21 INFO - PROCESS | 1987 | |3;audio-fft;80;59;81;88;63;58;57;58;85;68 03:40:21 INFO - PROCESS | 1987 | |4;audio-oscillator;88;71;91;90;92;94;103;67;68;90 03:40:21 INFO - PROCESS | 1987 | |5;imaging-gaussian-blur;117;87;89;86;88;86;90;87;90;87 03:40:21 INFO - PROCESS | 1987 | |6;imaging-darkroom;132;97;95;95;95;94;96;96;95;94 03:40:21 INFO - PROCESS | 1987 | |7;imaging-desaturate;84;87;86;84;86;89;91;86;84;84 03:40:21 INFO - PROCESS | 1987 | |8;json-parse-financial;56;53;52;52;56;57;58;56;57;56 03:40:21 INFO - PROCESS | 1987 | |9;json-stringify-tinderbox;67;77;66;79;74;70;70;75;71;71 03:40:21 INFO - PROCESS | 1987 | |10;stanford-crypto-aes;81;85;81;82;82;84;78;82;81;82 03:40:21 INFO - PROCESS | 1987 | |11;stanford-crypto-ccm;138;138;140;142;147;132;141;134;193;156 03:40:21 INFO - PROCESS | 1987 | |12;stanford-crypto-pbkdf2;175;194;171;169;171;172;168;169;170;168 03:40:21 INFO - PROCESS | 1987 | |13;stanford-crypto-sha256-iterative;69;68;69;69;69;70;68;67;68;68 03:40:21 INFO - PROCESS | 1987 | __end_tp_report 03:40:21 INFO - PROCESS | 1987 | __start_cc_report 03:40:21 INFO - PROCESS | 1987 | _x_x_mozilla_cycle_collect,1936 03:40:21 INFO - PROCESS | 1987 | __end_cc_report 03:40:21 INFO - PROCESS | 1987 | __startTimestamp1478342421127__endTimestamp 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | ------- Summary: start ------- 03:40:21 INFO - PROCESS | 1987 | Number of tests: 14 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 03:40:21 INFO - PROCESS | 1987 | Values: 115.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 115.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:133.00 stddev:15.80 (11.9%) stddev-sans-first:15.31 03:40:21 INFO - PROCESS | 1987 | Values: 144.0 134.0 132.0 140.0 109.0 109.0 108.0 106.0 143.0 132.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.49 (0.8%) stddev-sans-first:1.56 03:40:21 INFO - PROCESS | 1987 | Values: 185.0 184.0 184.0 187.0 182.0 182.0 185.0 184.0 185.0 185.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#3] audio-fft Cycles:10 Average:69.70 Median:74.00 stddev:12.47 (16.9%) stddev-sans-first:12.66 03:40:21 INFO - PROCESS | 1987 | Values: 80.0 59.0 81.0 88.0 63.0 58.0 57.0 58.0 85.0 68.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:90.00 stddev:12.28 (13.6%) stddev-sans-first:12.99 03:40:21 INFO - PROCESS | 1987 | Values: 88.0 71.0 91.0 90.0 92.0 94.0 103.0 67.0 68.0 90.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:87.50 stddev:9.36 (10.7%) stddev-sans-first:1.56 03:40:21 INFO - PROCESS | 1987 | Values: 117.0 87.0 89.0 86.0 88.0 86.0 90.0 87.0 90.0 87.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#6] imaging-darkroom Cycles:10 Average:98.90 Median:95.00 stddev:11.67 (12.3%) stddev-sans-first:0.97 03:40:21 INFO - PROCESS | 1987 | Values: 132.0 97.0 95.0 95.0 95.0 94.0 96.0 96.0 95.0 94.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:2.38 (2.8%) stddev-sans-first:2.40 03:40:21 INFO - PROCESS | 1987 | Values: 84.0 87.0 86.0 84.0 86.0 89.0 91.0 86.0 84.0 84.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:2.16 (3.9%) stddev-sans-first:2.28 03:40:21 INFO - PROCESS | 1987 | Values: 56.0 53.0 52.0 52.0 56.0 57.0 58.0 56.0 57.0 56.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.50 stddev:4.19 (5.8%) stddev-sans-first:4.03 03:40:21 INFO - PROCESS | 1987 | Values: 67.0 77.0 66.0 79.0 74.0 70.0 70.0 75.0 71.0 71.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.87 (2.3%) stddev-sans-first:1.96 03:40:21 INFO - PROCESS | 1987 | Values: 81.0 85.0 81.0 82.0 82.0 84.0 78.0 82.0 81.0 82.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:141.50 stddev:17.81 (12.6%) stddev-sans-first:18.65 03:40:21 INFO - PROCESS | 1987 | Values: 138.0 138.0 140.0 142.0 147.0 132.0 141.0 134.0 193.0 156.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:171.00 stddev:7.78 (4.5%) stddev-sans-first:8.20 03:40:21 INFO - PROCESS | 1987 | Values: 175.0 194.0 171.0 169.0 171.0 172.0 168.0 169.0 170.0 168.0 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - PROCESS | 1987 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 03:40:21 INFO - PROCESS | 1987 | Values: 69.0 68.0 69.0 69.0 69.0 70.0 68.0 67.0 68.0 68.0 03:40:21 INFO - PROCESS | 1987 | -------- Summary: end -------- 03:40:21 INFO - PROCESS | 1987 | 03:40:21 INFO - TEST-INFO | 1987: exit 0 03:40:21 INFO - TEST-OK | kraken | took 59040ms 03:40:21 INFO - SUITE-END | took 1176s 03:40:22 INFO - Completed test suite (00:19:36) 03:40:22 INFO - javascript benchmark 03:40:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.069820450274, 3346.364190803747, 3369.713574346179, 3377.408953433149, 3409.301093275879, 5825.067989121741, 5839.737211825467, 5850.239468869052, 5858.765649374025, 5880.588358814879, 5768.192453056565, 5837.7373018214175, 5845.298564172294, 5845.912311315334, 5856.443637854397, 5236.423993360727, 5250.31745873036, 5291.523762861341, 5309.654872433299, 5319.148936170213, 5183.663061900983, 5186.844394668166, 5189.948100519003, 5332.466753324676, 5344.251804747339, 5256.684598924057, 5282.471752824706, 5294.470552944713, 5296.947030529684, 5303.814366497173, 5299.894002119974, 5346.545543628797, 5360.0083984463, 5364.383095943977, 5386.434424385422, 5141.177411614124, 5198.090334191539, 5210.687358758449, 5288.233206185082, 5316.9734151329385, 4547.931781023287, 5671.546276297886, 5753.108268218432, 5775.1337299405, 5779.508741756956, 6194.690265486708, 6286.779962701284, 6304.401081897213, 6304.873902521924, 6308.022256550196, 4733.55031272032, 6240.87518249637, 6311.147995020659, 6311.431971122621, 6338.207724034496, 5678.261825962681, 5723.313202415737, 5729.083346664514, 5806.274215723035, 5897.233359663259, 6219.689015549295, 6240.5319601030105, 6271.498280137578, 6279.905801412982, 6287.779927702509, 6236.750529978841, 6238.844028899223, 6246.843828904313, 6250.3749625037135, 6251.99968005117, 6148.262208535004, 6159.291681456601, 6241.750329986749, 6318.71565779541, 6322.336154703782, 6215.81352559424, 6276.811695649047, 6311.684415779285, 6314.242290925026, 6321.652309123042, 6280.403361680633, 6312.810615681537, 6319.9368006320265, 6327.715252813635, 6330.873382532323, 4830.8309209178215, 4920.507949205051, 4979.228219625964, 4998.800047998112, 5012.298278241049, 3773.0, 4447.6219521341045, 4492.775361231991, 4519.570640789186, 4580.770961451981, 5879.911801322984, 5885.146653735184, 5885.911711324334, 5888.676122813286, 5896.174535565025, 6282.654454005074, 6292.182016337847, 6304.18045654062, 6304.243490781136, 6308.274548426898, 5690.317161940594, 5725.971370143206, 5779.24869766936, 5782.826515204551, 5839.0949402842625, 5472.179173123984, 5483.122700367922, 5489.945100549024, 5494.670319780826, 5498.835034948878, 6295.905561416491, 6310.558260921784, 6312.905306420407, 6315.400036996478, 6320.27316858558, 6202.56582039271, 6248.312685604489, 6266.467350275278, 6319.936800631935, 6326.082718005955, 6213.65824879636, 6242.282137554058, 6260.530460215411, 6309.716062777278, 6314.810555683337, 6252.499800016079, 6264.404881536247, 6276.215473065867, 6278.121063051268, 6285.308616052139, 6103.603265787887, 6157.53818463626, 6234.220722409699, 6266.624002559861, 6295.842603934938, 6015.368386319374, 6034.064719968412, 6036.275646922398, 6115.113308570321, 6139.093519790236, 6141.63943600049, 6142.324344322032, 6147.170132032118, 6157.6613286269685, 6184.165137706532, 5952.226210592596, 5990.460858522754, 6008.7296071676, 6013.0, 6015.819525414245, 5962.582619216613, 6034.78878239277, 6061.878762424639, 6096.786612468542, 6097.420745029215, 5998.9100163496705, 6000.489958353589, 6017.06735456005, 6039.6678182698615, 6079.817605471843], "value": 5736.955534459884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.17679941304766, 474.79346484279364, 497.9153543897537, 511.6929842094744, 532.5739408473222, 30385.24036899076, 38350.0, 40783.59216407835, 40852.795736021275, 41683.74948751542, 42959.14081718364, 43116.35325470121, 43232.56767432325, 43258.0, 43381.566184338146, 9650.999999999982, 9823.754406139868, 9836.458994755285, 9846.458444785534, 9914.652987145451, 8737.038925718198, 8964.238039766627, 11919.40402979852, 12150.574729884456, 12164.02687784975, 12024.819627705592, 12034.33811140387, 12044.397780111003, 12063.095267854902, 12078.0, 8638.09300023501, 12090.516379344816, 12145.149839511238, 12152.392380380945, 12180.573679921205, 7673.884891726629, 11582.247153934968, 11920.165588408814, 11946.984506316974, 12207.450664720109, 41253.0, 41612.58387416117, 41628.1674366514, 41644.37533437001, 41695.374569381485, 3391.5421418108485, 3570.0539357070397, 3622.873199438007, 3975.463312452811, 4023.8189281482405, 29750.85124574385, 29967.400651986838, 31551.89568365096, 32487.86292479752, 32497.0, 3159.3207460395897, 3181.96818031819, 3254.267789747288, 3330.7834990725523, 3367.764256502046, 533615.0, 543126.0, 543946.0, 546406.0, 546487.2675636637, 61656.69171654113, 62033.689831551455, 62048.68975655183, 62101.0, 62204.37795621986, 34652.0, 34809.65190348115, 34867.65132348695, 37075.258494829955, 65133.0, 16652.83347166537, 16779.91610041942, 16790.496285111465, 16815.495535133967, 16841.831581684026, 11964.82052769209, 12349.691257718629, 13203.603891883258, 13293.268870212038, 13317.0, 16436.589085272964, 18910.338138165374, 19113.522161945784, 20049.742105550715, 20150.09324580368, 7886.411682684365, 7949.920500794918, 7971.003624546932, 7989.640466178919, 8098.704207326799, 878.8901387326584, 1007.8992100790009, 1065.5577935156978, 1089.4171618184391, 1100.7743412600398, 30186.396272074435, 30279.545806812916, 30480.171189728688, 30813.537796933066, 30830.84584577063, 1083.0739717541546, 1095.9890401095886, 1138.2089447833841, 1166.1487114406361, 1188.2276520261898, 15217.6195595111, 15626.531204063896, 15733.44932927365, 15976.360945562048, 16113.838861611233, 725517.0, 730363.0, 731665.0, 732006.0, 734474.0, 58803.41196588065, 59118.70440647769, 59189.704051479464, 59471.0, 59530.404695952486, 1266.1896386312767, 1281.9935900320252, 1318.6241921052647, 1370.164199838078, 1400.0969374753226, 29429.96995105161, 31318.0, 31367.372652546364, 31409.685903140675, 32158.67841321557, 49191.754041229564, 49829.50170498249, 49870.0, 49883.0, 49913.75043124761, 540312.0, 543481.0, 543514.0, 545354.0, 546623.0, 22775.0, 26870.0, 26952.056678016175, 26980.73019269782, 28254.85872570624, 48045.0, 48218.75890620524, 48397.27404088871, 48709.269360958904, 48935.0, 38320.0, 39053.609463906134, 39333.26333998266, 40855.59144408518, 41220.1755964873, 37464.68873589411, 37470.0, 38325.61674383221, 39789.0, 39907.80276591707, 38092.80953595214, 38321.04197395087, 38415.23169536649, 38596.42105368478, 38602.0, 31023.914163004185, 33566.664333356355, 34930.0, 35597.64402356047, 36222.91331260066, 25512.107076252243, 25735.613965790904, 25876.0, 26153.60769588496, 26302.34244143835], "value": 20515.979334873773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.6897791987211, 350.9052555809933, 358.9554396705586, 364.69001348853476, 366.69197873786015, 14960.775588366183, 15104.848951510496, 16178.19109044546, 17525.298988040497, 20970.37088887332, 19708.802911970877, 19915.904625245606, 19998.50003749907, 20314.0, 20573.382798516068, 4548.704334218265, 5426.131818908985, 5695.430456954313, 5708.1152421374545, 5899.144624029514, 5612.130119831412, 5783.392743761908, 6149.0, 6190.442860142586, 6210.968945155268, 6134.539909506782, 6139.8772024559485, 6141.017437210047, 6147.815565533019, 6150.538709596775, 5795.101759227306, 6069.787557435468, 6145.661988590626, 6187.381261873822, 6191.349908259613, 5781.971090144564, 5970.223870896799, 6006.759729610811, 6032.607880487798, 6039.124326972608, 11315.207935444521, 13200.603981880558, 13414.86585134146, 13512.662183445394, 20622.58754824895, 2255.4474153832252, 2367.905283788664, 2522.230719630512, 2844.928876778097, 2999.505081661545, 9412.717618471457, 10009.499525023792, 10465.79068418635, 10500.212484063726, 10519.368837869752, 1874.250299880059, 1909.4176276235742, 1999.2602736987262, 2001.1795163982842, 2068.834493240537, 80461.0, 94019.52990235074, 114354.99999999917, 126445.01278772323, 137802.999999999, 11645.941770291263, 11650.30098194111, 11761.05911527093, 11808.46861891217, 11934.3436111013, 12825.23048617086, 14669.48656797007, 14825.62935926589, 14864.513548645265, 14866.033707808958, 8557.657693692183, 8676.566171691517, 8703.086175951561, 8712.869306960401, 8836.779080523038, 8646.956765216133, 8655.307575393954, 8674.436161649473, 8792.60433280504, 8820.073892241351, 3902.3951287550476, 4404.515503294635, 4556.863294101182, 4578.702384345073, 4596.540345965377, 1898.6392585408728, 1975.5851271233203, 1983.1670698306746, 1993.1927569334443, 1993.8504612154147, 727.4689476682051, 881.9559022048871, 929.4098247612815, 963.7253382785873, 988.2143695761887, 19594.412167634993, 20739.58520829575, 20785.58428831415, 20980.05589748465, 21314.934253287272, 925.5233554719325, 935.3078721745995, 974.5161049248964, 976.9560369783377, 993.2203220471895, 9163.633454661738, 10318.43248621333, 10967.122630189566, 10978.176636752276, 10981.835272470918, 601124.0, 603077.0, 612548.0, 613133.0, 613159.0, 106911.0, 128223.0, 132754.33622831825, 135784.0, 141679.5832041687, 863.2144748279161, 883.2580632268925, 965.7826988927435, 966.1353088985319, 968.1480297338297, 16369.0, 16407.753883691516, 18047.09764511743, 18820.435386937865, 18925.810741892954, 56694.14958775539, 57142.0, 58262.708686456295, 59733.10400344085, 59751.0, 73238.26761732314, 73437.0, 76989.0, 80145.79781303402, 80745.0, 7276.636168191675, 7958.920410795818, 7971.1630278819885, 8162.83674326522, 8472.279856212292, 10758.515866785858, 12364.381780911099, 13213.933930330288, 13375.598732038054, 13491.123076999964, 6315.55791094619, 11272.605458808903, 11700.590479333523, 11818.881811182122, 11881.762364752829, 11035.834462482908, 11288.322700637988, 11336.0, 11478.540858365572, 11844.70388240301, 5803.390643982321, 8526.872096918427, 9519.857202141835, 11191.832122518332, 11535.36555489456, 8234.464759790595, 8281.29608983219, 8356.87464688018, 8428.072911979554, 8508.276796472122, 10825.945870270598, 11055.83416248773, 11334.093272538343, 11635.650930472098, 11764.529418823151], "value": 9370.306990478039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.1834918318698, 1553.7125631758126, 1586.4050980882168, 1724.120698443794, 1865.6455273498025, 8481.575921203937, 9052.366334356597, 9052.95473522633, 9058.864117038249, 9065.093490650948, 7826.1391246962785, 8166.959165204181, 8186.631601577928, 8256.422050456455, 8270.875936860937, 2145.5065334972965, 2346.3195673254736, 2424.2242482405636, 2424.6726691896633, 2435.2937648082034, 2404.987975060131, 2410.0, 2430.586800243963, 2431.7932975697, 2434.987825060872, 2423.4183795889035, 2425.4300239443714, 2428.1865575032384, 2428.720697119836, 2429.671994280767, 2380.940476488084, 2418.5404773093146, 2419.709634843812, 2426.3085020768995, 2426.3206302235403, 2395.0060724799187, 2403.230966090852, 2421.987890060556, 2423.5031818477346, 2425.4421483058995, 8867.68963086289, 8888.822223555493, 8968.865467018, 8980.012198658142, 8994.820103597956, 5247.055530004598, 5384.246205531229, 5392.946070539323, 5400.081986062379, 5408.242846001563, 3533.3463309287863, 3557.181848174934, 3607.6572725591027, 3687.3547129252274, 3688.483612294281, 1082.8105081610686, 1090.5528733219421, 1091.9454027298602, 1108.130117857478, 1110.3781882146025, 11663.941680291544, 11683.065354771683, 11810.350430726307, 11833.290002599872, 11863.881361186364, 4645.001324715135, 4703.882402939886, 4868.367112275381, 4882.389701287339, 4895.485973972753, 10035.849462258071, 10074.546645400975, 10075.848862267072, 10077.546510406903, 10096.091351778376, 5368.516833485005, 5377.569794416516, 5387.784488620411, 5395.62230643859, 5397.676139431646, 4278.828846846091, 4776.355192049029, 4908.852734417973, 4945.307656928033, 4961.305417241589, 3494.4408894577255, 3964.7224694271126, 3982.7809470478824, 3994.78028708418, 4085.6731461483605, 1287.587971849018, 1294.786360250567, 1301.7982212757038, 1309.8166256724066, 1321.431784332727, 763.3549650545281, 870.8650159225331, 897.8787863638325, 923.4874644572193, 927.4852456886492, 5823.650580965155, 5902.61632993854, 5970.58205925581, 6017.007193812972, 6087.995480745627, 821.3962737388015, 903.9141281578239, 920.8987011428737, 979.4123525884412, 996.8155891160159, 3843.3082045231567, 4018.7789671568344, 4041.8989525262105, 4077.959220407817, 4162.875113746592, 10683.14534837211, 10896.673099807018, 11013.559457621606, 11019.944900275448, 11031.724206894893, 10960.780784384267, 10975.560977560808, 10977.28647637901, 10978.670639880816, 11006.0, 8189.631466583899, 8273.958630206931, 8336.499810011297, 8337.583120843934, 8340.37447191463, 4821.566059054702, 4938.950610493993, 5936.465718085393, 6046.758129674764, 6049.758009679564, 10044.146247569039, 10128.189744820544, 10296.382217067, 10324.122449591869, 10380.42907640057, 9870.358426702242, 10235.334703244265, 10429.739256518647, 10515.05364517197, 10533.9473302633, 6668.866622667422, 6888.758893438706, 6899.344562266577, 7015.228324884157, 7136.571805691675, 8562.957185214034, 8603.698870539502, 8657.826843463221, 8677.0, 8677.1756683115, 7665.348445382205, 7696.114946781192, 7698.846023079619, 7735.381169506539, 7824.765257042298, 7342.449316301192, 7495.138059123271, 7577.5453472791805, 7619.542827430372, 7622.123455802654, 7027.6837542309695, 7151.681810935806, 7215.314545118205, 7219.2780721929485, 7225.313595208447, 4941.925871111865, 4986.252062190701, 5087.618428617942, 5149.124648809637, 5217.8173763918085, 5027.824026159067, 5030.421501527371, 5191.065608190562, 5240.161574148118, 5328.440513746001], "value": 4644.54359298653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.78355830427532, 288.4274714691337, 294.880573367786, 298.5000124790975, 308.78847989127433, 4637.930431043537, 5300.6819590824525, 5392.43379445158, 5441.156620723789, 5503.624093976506, 4860.0, 5145.742712864351, 5295.31160949077, 5376.758045887935, 5469.507744303012, 3367.8147701876323, 3478.286951175003, 4052.7973601319964, 4110.424540564323, 4115.670746340301, 4087.608748881893, 4087.713860029799, 4094.9385759213637, 4095.0548489467565, 4140.441040459529, 3422.5550678411896, 3431.6053653829754, 3471.375152472554, 3966.52401711795, 4057.918841623166, 3303.1832492129474, 4065.0, 4072.6945479089186, 4085.387191921206, 4242.136557823473, 3190.3778763141195, 3298.6805277889034, 3319.983400082984, 3444.3111377724554, 3556.715462762973, 5166.250893620404, 5173.715445650488, 5218.321618189649, 5219.530242278213, 5226.477352264743, 4302.698811083225, 4543.8182472701055, 4595.7702114894455, 4631.583157515806, 4691.202495575761, 4966.573064585425, 4998.7250701211415, 5234.947650523484, 5649.858753531194, 5670.432956704338, 3440.690337869604, 3870.1679138984973, 3878.728489005771, 3897.590752970954, 3898.9220215595815, 5031.572316353151, 5218.990688584884, 5715.457031581993, 5800.709096769369, 5983.730732117066, 3522.9295414091575, 3703.8888833334504, 3851.768893866377, 3936.0946982194255, 3944.9211015779524, 3397.9660203398143, 3427.3488037272837, 3524.7708898922, 3924.5290565131795, 3938.6455219030427, 4183.811728472226, 4219.599138081878, 4585.564371384713, 4622.953770462253, 4665.790039448233, 4971.751412429364, 5174.741262936914, 5712.542996560265, 5725.570582206351, 5761.308642962787, 1158.779831831966, 1246.429498831479, 1351.3986276107235, 1358.4566173530666, 1359.4358341288255, 835.8035861572525, 861.8836457078339, 873.3711627814081, 940.1820416237916, 961.9230461563059, 5116.974415127975, 5369.228154708937, 5449.174526533577, 5461.863453413617, 5470.9452905471235, 5684.37471878093, 5809.3609702932645, 5837.036888913367, 5921.822345329647, 5947.702614869239, 4634.582887540138, 5096.388433388017, 5275.841724748264, 5289.074411977888, 5411.648242864201, 2800.943981120366, 2819.631509532003, 2884.5817356483194, 2955.748761355309, 2986.9694955240407, 5110.718910459886, 5631.070873305941, 5767.653940763567, 5922.911156332659, 5932.40675932412, 5833.854153646108, 5842.298924129047, 5879.2944846618675, 5936.5547583931375, 5975.731092100866, 5837.832433513315, 5873.559483038704, 5908.852278692981, 5922.378150294329, 6000.5799594028, 5042.319286896369, 5601.04782187021, 5705.857353566028, 5829.65917838891, 5897.734601943009, 5333.146696528537, 5697.800576979786, 5732.942670573408, 5738.9913530264075, 5748.770049198152, 4774.021325628308, 5294.682319060868, 5853.0635098384055, 5896.611872191769, 5946.840366128564, 3350.463925771865, 3494.5981212160927, 3848.6138594071854, 3885.475460812754, 3945.427912952663, 4818.445878723852, 5350.545203657577, 5575.470330318613, 5591.077472217039, 5932.436418540232, 5239.214117882349, 5548.2549279235545, 5553.194786755978, 5827.533797296291, 5835.124731290341, 5715.571332150189, 5730.570207234391, 5732.656040637575, 5753.942460575341, 5766.163906233656, 5380.515753582196, 5549.306336707911, 5623.862932085781, 5652.604317697722, 5674.319081710221, 5153.896922061613, 5559.444055594408, 5613.073842816053, 5646.576506761927, 5650.0, 4381.304304404325, 5527.462424048693, 5538.756803494591, 5616.85957851057, 5622.353429355677], "value": 4093.6935618428374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.7465013994401, 781.238292664652, 803.5459965119709, 808.2483290539803, 811.6428771340613, 15194.620134496628, 15863.0, 16538.586535336606, 16543.17284135793, 16722.66554668906, 13374.933125334359, 13716.588502344946, 13716.862831371684, 13732.519361822338, 13766.724665506685, 677.7187467201105, 845.1168528887312, 867.5488745852153, 869.0527325215514, 869.9086595907434, 706.7561691216522, 714.6676795290189, 839.2614499240659, 862.8446879561676, 863.995680021599, 915.0483497162976, 920.2499962530517, 921.7280902133853, 922.6401703335705, 922.6862866625346, 913.0139449394671, 914.3553794574875, 915.5285028210477, 916.7020718266523, 918.554501066982, 534.625761966621, 550.435803301615, 656.9671516424207, 672.653583404547, 679.300320669711, 15542.0, 15609.92195039029, 15618.843811561852, 15621.062736235748, 15624.296906639229, 13914.582562523039, 14183.716325673531, 14263.857361426357, 14330.0, 14446.783298250535, 12214.57248996281, 12511.249325040526, 12546.121771476, 12940.288284144368, 13224.471021159143, 4469.776511174428, 4485.798139083749, 4510.233260345716, 4568.725876447391, 4589.449266088058, 120835.0, 124953.0, 127568.0, 128929.35535322357, 132185.3562928736, 10903.29128606638, 11029.669109926715, 11263.493142808593, 11269.830952535718, 11295.830562541569, 22329.888350558143, 22420.43948901258, 22457.887710561343, 22470.10119595198, 22475.775242247695, 8092.583712938478, 8106.0, 8200.220979006985, 8263.214994575506, 8324.6670133194, 3841.692664586826, 4407.537208593051, 4520.773961301922, 4541.568550987651, 4721.244600863845, 3492.7729697570085, 3636.054625797312, 3639.836207370675, 3640.563132424073, 3652.36083685354, 623.5167744997663, 624.2883113250898, 624.6408315218677, 630.9242890853127, 639.3670266436195, 521.7000224870638, 534.3027349309111, 545.4736179586718, 615.4553220399889, 650.3691419323249, 9040.276777857756, 9269.72190834276, 9358.906410935804, 9409.905900940903, 9578.185854202331, 605.3734384911595, 630.6027202862167, 634.9587276827084, 642.3608509532951, 645.7998020613625, 4390.980742099689, 4457.598816106566, 4503.437070366204, 4514.367988481616, 4617.238155704271, 106893.0, 106911.0, 109841.0, 156433.0, 168218.0, 110025.0, 118591.0, 122067.0, 141883.0, 142208.0, 109371.0, 118904.8657080578, 119136.8086319143, 122470.0, 125914.37042814911, 8561.61472733741, 8739.650413983623, 8740.956295218737, 8815.559222039, 8911.37620366568, 60096.39903600908, 61264.46838829065, 64832.67583662052, 64866.0, 65630.67184664046, 88650.22699546102, 88817.55591222002, 95486.52256738672, 100062.0, 101299.0, 13019.674508137372, 13202.603921882359, 13270.734585308433, 13505.662358441117, 13804.723905522034, 12586.685332866751, 13118.475260989453, 15180.208914759607, 15619.609509761893, 16127.77987934763, 13814.585562433143, 14451.988360814643, 14520.201388923711, 15098.622534436727, 15113.942024058211, 11156.721081973015, 13937.024408291321, 14003.299835008413, 14037.5086871959, 14377.7843332348, 13410.865891341353, 13920.164790112625, 13963.232022238875, 14072.552224705012, 14832.7775083376, 10831.962514331415, 11159.27464714791, 11361.943190283995, 11849.703757406134, 11918.880811191777, 9862.802743945225, 11117.27737697047, 11267.211295209258, 11381.886181138083, 11640.243384180001], "value": 7901.560328686861, "unit": "score"}], "name": "dromaeo_css", "value": 7411.239125956447, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 132.0, 140.0, 109.0, 109.0, 108.0, 106.0, 143.0, 132.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 187.0, 182.0, 182.0, 185.0, 184.0, 185.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 81.0, 88.0, 63.0, 58.0, 57.0, 58.0, 85.0, 68.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 91.0, 90.0, 92.0, 94.0, 103.0, 67.0, 68.0, 90.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 87.0, 89.0, 86.0, 88.0, 86.0, 90.0, 87.0, 90.0, 87.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 97.0, 95.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 94.0], "value": 98.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 86.0, 84.0, 86.0, 89.0, 91.0, 86.0, 84.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 52.0, 56.0, 57.0, 58.0, 56.0, 57.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 66.0, 79.0, 74.0, 70.0, 70.0, 75.0, 71.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 81.0, 82.0, 82.0, 84.0, 78.0, 82.0, 81.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 142.0, 147.0, 132.0, 141.0, 134.0, 193.0, 156.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 194.0, 171.0, 169.0, 171.0, 172.0, 168.0, 169.0, 170.0, 168.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 67.0, 68.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1451.4, "alertThreshold": 2.0}]} 03:40:22 INFO - Return code: 0 03:40:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:22 INFO - # TBPL SUCCESS # 03:40:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:22 INFO - 2016-11-05 03:40:22.466 screenresolution[1991:19916] starting screenresolution argv=screenresolution get 03:40:22 INFO - 2016-11-05 03:40:22.468 screenresolution[1991:19916] Display 0: 1600x1200x32@60 03:40:22 INFO - 2016-11-05 03:40:22.474 screenresolution[1992:19919] starting screenresolution argv=screenresolution list 03:40:22 INFO - Available Modes on Display 0 03:40:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:22 INFO - Intel Iris: 03:40:22 INFO - Chipset Model: Intel Iris 03:40:22 INFO - Type: GPU 03:40:22 INFO - Bus: Built-In 03:40:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:22 INFO - Vendor: Intel (0x8086) 03:40:22 INFO - Device ID: 0x0a2e 03:40:22 INFO - Revision ID: 0x0009 03:40:22 INFO - Displays: 03:40:22 INFO - Display: 03:40:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:22 INFO - Display Serial Number: 1600x1200 60 03:40:22 INFO - Main Display: Yes 03:40:22 INFO - Mirror: Off 03:40:22 INFO - Online: Yes 03:40:22 INFO - Rotation: Supported 03:40:22 INFO - Return code: 0 03:40:22 INFO - Running post-action listener: _resource_record_post_action 03:40:22 INFO - [mozharness: 2016-11-05 10:40:22.708565Z] Finished run-tests step (success) 03:40:22 INFO - Running post-run listener: _resource_record_post_run 03:40:22 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 987136; Write bytes: 662528000; Read time: 8; Write time: 2020 03:40:22 INFO - TinderboxPrint: CPU usage
53.6% 03:40:22 INFO - TinderboxPrint: I/O read bytes / time
987,136 / 8 03:40:22 INFO - TinderboxPrint: I/O write bytes / time
662,528,000 / 2,020 03:40:22 INFO - TinderboxPrint: CPU idle
2,245.7 (46.4%) 03:40:22 INFO - TinderboxPrint: CPU system
974.7 (20.1%) 03:40:22 INFO - TinderboxPrint: CPU user
1,617.2 (33.4%) 03:40:22 INFO - TinderboxPrint: Swap in / out
363,802,624 / 0 03:40:22 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358377984; Write bytes: 355575296; Read time: 27526; Write time: 666 03:40:22 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 151552; Write bytes: 295913984; Read time: 4; Write time: 1296 03:40:23 INFO - Running post-run listener: _upload_blobber_files 03:40:23 INFO - Blob upload gear active. 03:40:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:24 INFO - (blobuploader) - INFO - Done attempting. 03:40:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:40:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:40:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:25 INFO - (blobuploader) - INFO - Done attempting. 03:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:27 INFO - (blobuploader) - INFO - Done attempting. 03:40:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:27 INFO - Return code: 0 03:40:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e566e00404f26aed47e3d25ee410cfd5fee890cc6cb5f8d58b76c72b29ff216edb93b3234a608b95be63217b929358aaafc4d191d86c33a7235644a610c0961f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad5679d20f7e7d6e4b6589784897b06c16042eac6ba0a42f950df856de81ef46403747fee2c38054ea14cecbd034d6870f96e7f2146cadc214d82349b407f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eac91b02fd635cd3a9f992dc2b96572fdf9236917b84dcbf055384b6fa289e127f2dad97a9448d109d05d58aab6925f95543bbdcf084c3137bf0c6c119bc3f2f"} 03:40:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:27 INFO - Contents: 03:40:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e566e00404f26aed47e3d25ee410cfd5fee890cc6cb5f8d58b76c72b29ff216edb93b3234a608b95be63217b929358aaafc4d191d86c33a7235644a610c0961f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad5679d20f7e7d6e4b6589784897b06c16042eac6ba0a42f950df856de81ef46403747fee2c38054ea14cecbd034d6870f96e7f2146cadc214d82349b407f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eac91b02fd635cd3a9f992dc2b96572fdf9236917b84dcbf055384b6fa289e127f2dad97a9448d109d05d58aab6925f95543bbdcf084c3137bf0c6c119bc3f2f"} 03:40:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:27 INFO - Copying logs to upload dir... 03:40:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.929731 ========= master_lag: 1.43 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 03:40:29.371859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 03:40:29.375398) ========= 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.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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/e566e00404f26aed47e3d25ee410cfd5fee890cc6cb5f8d58b76c72b29ff216edb93b3234a608b95be63217b929358aaafc4d191d86c33a7235644a610c0961f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad5679d20f7e7d6e4b6589784897b06c16042eac6ba0a42f950df856de81ef46403747fee2c38054ea14cecbd034d6870f96e7f2146cadc214d82349b407f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eac91b02fd635cd3a9f992dc2b96572fdf9236917b84dcbf055384b6fa289e127f2dad97a9448d109d05d58aab6925f95543bbdcf084c3137bf0c6c119bc3f2f"} build_url:https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011627 build_url: 'https://queue.taskcluster.net/v1/task/SQVszZvGQPmrU0u-6l2yyQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e566e00404f26aed47e3d25ee410cfd5fee890cc6cb5f8d58b76c72b29ff216edb93b3234a608b95be63217b929358aaafc4d191d86c33a7235644a610c0961f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ad5679d20f7e7d6e4b6589784897b06c16042eac6ba0a42f950df856de81ef46403747fee2c38054ea14cecbd034d6870f96e7f2146cadc214d82349b407f1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eac91b02fd635cd3a9f992dc2b96572fdf9236917b84dcbf055384b6fa289e127f2dad97a9448d109d05d58aab6925f95543bbdcf084c3137bf0c6c119bc3f2f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 03:40:29.413346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:40:29.413674) ========= 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.aDhY7mJCfA/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.4nakKRNYar/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005207 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 03:40:29.462017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 03:40:29.462375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 03:40:29.462711) ========= ========= Total master_lag: 1.63 =========