builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0129 starttime: 1486116368.68 results: success (0) buildid: 20170203004018 builduid: 4c976020693d4dcda79d5be0d038d979 revision: ed726703c08c7a0398d349efaded8bdea25c46ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.679410) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.679841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.680118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.706490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.706826) ========= 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.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-03 02:06:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2017-02-03 02:06:08 (14.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.859272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.859598) ========= 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.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.029203 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:08.913309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 02:06:08.913676) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ed726703c08c7a0398d349efaded8bdea25c46ff --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 ed726703c08c7a0398d349efaded8bdea25c46ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-03 02:06:09,017 truncating revision to first 12 chars 2017-02-03 02:06:09,017 Setting DEBUG logging. 2017-02-03 02:06:09,017 attempt 1/10 2017-02-03 02:06:09,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ed726703c08c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 02:06:10,713 unpacking tar archive at: mozilla-aurora-ed726703c08c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.971217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 02:06:10.906664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:10.907039) ========= script_repo_revision: ed726703c08c7a0398d349efaded8bdea25c46ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:10.907474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:10.907743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 02:06:10.928063) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-03 02:06:10.928459) ========= /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.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:11 INFO - MultiFileLogger online at 20170203 02:06:11 in /builds/slave/test 02:06:11 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 02:06:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:11 INFO - {'append_to_log': False, 02:06:11 INFO - 'base_work_dir': '/builds/slave/test', 02:06:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:06:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:11 INFO - 'branch': 'Mozilla-Aurora', 02:06:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:11 INFO - 'config_files': ('talos/mac_config.py',), 02:06:11 INFO - 'default_actions': ('clobber', 02:06:11 INFO - 'read-buildbot-config', 02:06:11 INFO - 'download-and-extract', 02:06:11 INFO - 'populate-webroot', 02:06:11 INFO - 'create-virtualenv', 02:06:11 INFO - 'install', 02:06:11 INFO - 'run-tests'), 02:06:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:11 INFO - 'download_minidump_stackwalk': True, 02:06:11 INFO - 'download_symbols': 'ondemand', 02:06:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:11 INFO - 'installer_path': 'installer.exe', 02:06:11 INFO - 'log_level': 'info', 02:06:11 INFO - 'log_name': 'talos', 02:06:11 INFO - 'log_to_console': True, 02:06:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:06:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:06:11 INFO - 'opt_config_files': (), 02:06:11 INFO - 'pip_index': False, 02:06:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:06:11 INFO - 'cmd': ('bash', 02:06:11 INFO - '-c', 02:06:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:06:11 INFO - 'enabled': True, 02:06:11 INFO - 'halt_on_failure': False, 02:06:11 INFO - 'name': 'check_screen_resolution'},), 02:06:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:06:11 INFO - 'cmd': ('bash', 02:06:11 INFO - '-c', 02:06:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:06:11 INFO - 'enabled': True, 02:06:11 INFO - 'halt_on_failure': False, 02:06:11 INFO - 'name': 'check_screen_resolution'},), 02:06:11 INFO - 'run_cmd_checks_enabled': True, 02:06:11 INFO - 'sps_profile': False, 02:06:11 INFO - 'sps_profile_interval': 0, 02:06:11 INFO - 'suite': 'dromaeojs', 02:06:11 INFO - 'system_bits': '32', 02:06:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:11 INFO - 'title': 't-yosemite-r7-0129', 02:06:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:11 INFO - 'use_talos_json': True, 02:06:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:11 INFO - 'work_dir': 'build'} 02:06:11 INFO - [mozharness: 2017-02-03 10:06:11.141326Z] Running clobber step. 02:06:11 INFO - Running pre-action listener: _resource_record_pre_action 02:06:11 INFO - Running main action method: clobber 02:06:11 INFO - rmtree: /builds/slave/test/build 02:06:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:06:14 INFO - Running post-action listener: _resource_record_post_action 02:06:14 INFO - [mozharness: 2017-02-03 10:06:14.041326Z] Finished clobber step (success) 02:06:14 INFO - [mozharness: 2017-02-03 10:06:14.041409Z] Running read-buildbot-config step. 02:06:14 INFO - Running pre-action listener: _resource_record_pre_action 02:06:14 INFO - Running main action method: read_buildbot_config 02:06:14 INFO - Using buildbot properties: 02:06:14 INFO - { 02:06:14 INFO - "project": "", 02:06:14 INFO - "product": "firefox", 02:06:14 INFO - "script_repo_revision": "production", 02:06:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:06:14 INFO - "repository": "", 02:06:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:06:14 INFO - "buildid": "20170203004018", 02:06:14 INFO - "stage_platform": "macosx64", 02:06:14 INFO - "basedir": "/builds/slave/test", 02:06:14 INFO - "nightly_build": "True", 02:06:14 INFO - "buildnumber": 38, 02:06:14 INFO - "slavename": "t-yosemite-r7-0129", 02:06:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:06:14 INFO - "platform": "yosemite_r7", 02:06:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:06:14 INFO - "branch": "mozilla-aurora", 02:06:14 INFO - "repo_path": "releases/mozilla-aurora", 02:06:14 INFO - "revision": "ed726703c08c7a0398d349efaded8bdea25c46ff", 02:06:14 INFO - "pgo_build": "False", 02:06:14 INFO - "builduid": "4c976020693d4dcda79d5be0d038d979", 02:06:14 INFO - "slavebuilddir": "test" 02:06:14 INFO - } 02:06:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:06:14 INFO - Running post-action listener: _resource_record_post_action 02:06:14 INFO - [mozharness: 2017-02-03 10:06:14.044817Z] Finished read-buildbot-config step (success) 02:06:14 INFO - [mozharness: 2017-02-03 10:06:14.044917Z] Running download-and-extract step. 02:06:14 INFO - Running pre-action listener: _resource_record_pre_action 02:06:14 INFO - Running main action method: download_and_extract 02:06:14 INFO - mkdir: /builds/slave/test/build/tests 02:06:14 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')]} 02:06:14 INFO - trying https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:06:14 INFO - Downloading https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:06:15 INFO - Downloaded 1199 bytes. 02:06:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:06:15 INFO - Using the following test package requirements: 02:06:15 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:06:15 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:06:15 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:06:15 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'jsshell-mac.zip'], 02:06:15 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:06:15 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:06:15 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:06:15 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:06:15 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:06:15 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:06:15 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:06:15 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:06:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:06:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:06:15 INFO - Fetch https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:06:16 INFO - Expected file size: 16356172 02:06:16 INFO - Obtained file size: 16356172 02:06:23 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:06:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:06:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:06:23 INFO - Fetch https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:06:24 INFO - Expected file size: 16356172 02:06:24 INFO - Obtained file size: 16356172 02:06:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:06:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:06:30 INFO - Fetch https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:06:31 INFO - Expected file size: 14403485 02:06:31 INFO - Obtained file size: 14403485 02:06:31 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')]} 02:06:31 INFO - trying https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:06:33 INFO - Downloaded 73951713 bytes. 02:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:06:33 INFO - mkdir: /builds/slave/test/properties 02:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:33 INFO - Contents: 02:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:06:34 INFO - Running post-action listener: _resource_record_post_action 02:06:34 INFO - Running post-action listener: set_extra_try_arguments 02:06:34 INFO - [mozharness: 2017-02-03 10:06:34.526847Z] Finished download-and-extract step (success) 02:06:34 INFO - [mozharness: 2017-02-03 10:06:34.526993Z] Running populate-webroot step. 02:06:34 INFO - Running pre-action listener: _resource_record_pre_action 02:06:34 INFO - Running main action method: populate_webroot 02:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:34 INFO - '--tppagecycles', 02:06:34 INFO - '7'], 02:06:34 INFO - 'tests': ['tsvgm']}}, 02:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['damp', 'tps']}, 02:06:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'tests': ['damp', 'tps']}, 02:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['dromaeo_dom']}, 02:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['basic_compositor_video']}, 02:06:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['a11yr', 02:06:34 INFO - 'ts_paint', 02:06:34 INFO - 'tpaint', 02:06:34 INFO - 'sessionrestore', 02:06:34 INFO - 'sessionrestore_no_auto_restore', 02:06:34 INFO - 'tabpaint']}, 02:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['tsvgx', 02:06:34 INFO - 'tsvgr_opacity', 02:06:34 INFO - 'tart', 02:06:34 INFO - 'tscrollx', 02:06:34 INFO - 'cart', 02:06:34 INFO - 'tsvg_static']}, 02:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:34 INFO - 'tsvgr_opacity', 02:06:34 INFO - 'tart', 02:06:34 INFO - 'tscrollx', 02:06:34 INFO - 'cart', 02:06:34 INFO - 'tsvg_static']}, 02:06:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'talos_options': ['--disable-e10s'], 02:06:34 INFO - 'tests': ['tp5o']}, 02:06:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:06:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'talos_options': ['--disable-e10s', 02:06:34 INFO - '--xperf_path', 02:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:34 INFO - 'tests': ['tp5n']}, 02:06:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:06:34 INFO - 'talos_options': ['--xperf_path', 02:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:34 INFO - 'tests': ['tp5n']}}, 02:06:34 INFO - 'talos.zip': {'path': '', 02:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:34 INFO - Running post-action listener: _resource_record_post_action 02:06:34 INFO - [mozharness: 2017-02-03 10:06:34.545287Z] Finished populate-webroot step (success) 02:06:34 INFO - [mozharness: 2017-02-03 10:06:34.545424Z] Running create-virtualenv step. 02:06:34 INFO - Running pre-action listener: _resource_record_pre_action 02:06:34 INFO - Running main action method: create_virtualenv 02:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:34 INFO - Using real prefix '/tools/python27' 02:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:38 INFO - Installing pip.................done. 02:06:38 INFO - Return code: 0 02:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:06:38 INFO - Reading from file tmpfile_stdout 02:06:38 INFO - Output received: 02:06:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:06:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:38 INFO - 'HOME': '/Users/cltbld', 02:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:38 INFO - 'LOGNAME': 'cltbld', 02:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:38 INFO - 'MOZ_NO_REMOTE': '1', 02:06:38 INFO - 'NO_EM_RESTART': '1', 02:06:38 INFO - 'PAGER': '/bin/cat', 02:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:38 INFO - 'PWD': '/builds/slave/test', 02:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:38 INFO - 'SHELL': '/bin/bash', 02:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:38 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:38 INFO - 'USER': 'cltbld', 02:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:38 INFO - 'XPC_FLAGS': '0x0', 02:06:38 INFO - 'XPC_SERVICE_NAME': '0', 02:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:06:38 INFO - Cleaning up... 02:06:38 INFO - Return code: 0 02:06:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:38 INFO - 'HOME': '/Users/cltbld', 02:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:38 INFO - 'LOGNAME': 'cltbld', 02:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:38 INFO - 'MOZ_NO_REMOTE': '1', 02:06:38 INFO - 'NO_EM_RESTART': '1', 02:06:38 INFO - 'PAGER': '/bin/cat', 02:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:38 INFO - 'PWD': '/builds/slave/test', 02:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:38 INFO - 'SHELL': '/bin/bash', 02:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:38 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:38 INFO - 'USER': 'cltbld', 02:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:38 INFO - 'XPC_FLAGS': '0x0', 02:06:38 INFO - 'XPC_SERVICE_NAME': '0', 02:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:39 INFO - Downloading/unpacking psutil>=3.1.1 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:39 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 02:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:42 INFO - Installing collected packages: psutil 02:06:42 INFO - Running setup.py install for psutil 02:06:42 INFO - building 'psutil._psutil_osx' extension 02:06:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:06:43 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 02:06:43 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 02:06:43 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 02:06:43 INFO - building 'psutil._psutil_posix' extension 02:06:43 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 02:06:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:06:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:06:43 INFO - ^ 02:06:43 INFO - 1 warning generated. 02:06:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:06:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:44 INFO - Successfully installed psutil 02:06:44 INFO - Cleaning up... 02:06:44 INFO - Return code: 0 02:06:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:06: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 mozsystemmonitor==0.3 02:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:44 INFO - 'HOME': '/Users/cltbld', 02:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:44 INFO - 'LOGNAME': 'cltbld', 02:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:44 INFO - 'MOZ_NO_REMOTE': '1', 02:06:44 INFO - 'NO_EM_RESTART': '1', 02:06:44 INFO - 'PAGER': '/bin/cat', 02:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:44 INFO - 'PWD': '/builds/slave/test', 02:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:44 INFO - 'SHELL': '/bin/bash', 02:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:44 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:44 INFO - 'USER': 'cltbld', 02:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:44 INFO - 'XPC_FLAGS': '0x0', 02:06:44 INFO - 'XPC_SERVICE_NAME': '0', 02:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:06:44 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 02:06:44 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 02:06:44 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 02:06:44 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 02:06:44 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 02:06:44 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 02:06:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:06:47 INFO - Installing collected packages: mozsystemmonitor 02:06:47 INFO - Running setup.py install for mozsystemmonitor 02:06:47 INFO - Successfully installed mozsystemmonitor 02:06:47 INFO - Cleaning up... 02:06:47 INFO - Return code: 0 02:06:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:06:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:47 INFO - 'HOME': '/Users/cltbld', 02:06:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:47 INFO - 'LOGNAME': 'cltbld', 02:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:47 INFO - 'MOZ_NO_REMOTE': '1', 02:06:47 INFO - 'NO_EM_RESTART': '1', 02:06:47 INFO - 'PAGER': '/bin/cat', 02:06:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:47 INFO - 'PWD': '/builds/slave/test', 02:06:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:47 INFO - 'SHELL': '/bin/bash', 02:06:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:47 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:47 INFO - 'USER': 'cltbld', 02:06:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:47 INFO - 'XPC_FLAGS': '0x0', 02:06:47 INFO - 'XPC_SERVICE_NAME': '0', 02:06:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:50 INFO - warning: no files found matching '*.txt' 02:06:50 INFO - no previously-included directories found matching 'build' 02:06:50 INFO - no previously-included directories found matching 'dist' 02:06:50 INFO - no previously-included directories found matching '.git*' 02:06:50 INFO - Installing collected packages: jsonschema, functools32 02:06:51 INFO - Running setup.py install for functools32 02:06:51 INFO - warning: no files found matching '*.txt' 02:06:51 INFO - no previously-included directories found matching 'build' 02:06:51 INFO - no previously-included directories found matching 'dist' 02:06:51 INFO - no previously-included directories found matching '.git*' 02:06:51 INFO - Successfully installed jsonschema functools32 02:06:51 INFO - Cleaning up... 02:06:51 INFO - Return code: 0 02:06:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:06:51 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')]} 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:51 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')]} 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:51 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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:51 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 02:06:51 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 02:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:51 INFO - 'HOME': '/Users/cltbld', 02:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:51 INFO - 'LOGNAME': 'cltbld', 02:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:51 INFO - 'MOZ_NO_REMOTE': '1', 02:06:51 INFO - 'NO_EM_RESTART': '1', 02:06:51 INFO - 'PAGER': '/bin/cat', 02:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:51 INFO - 'PWD': '/builds/slave/test', 02:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:51 INFO - 'SHELL': '/bin/bash', 02:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:51 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:51 INFO - 'USER': 'cltbld', 02:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:51 INFO - 'XPC_FLAGS': '0x0', 02:06:51 INFO - 'XPC_SERVICE_NAME': '0', 02:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:06:51 INFO - Cleaning up... 02:06:51 INFO - Return code: 0 02:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:51 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')]} 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:51 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')]} 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:51 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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:51 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 02:06:51 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 02:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:51 INFO - 'HOME': '/Users/cltbld', 02:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:51 INFO - 'LOGNAME': 'cltbld', 02:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:51 INFO - 'MOZ_NO_REMOTE': '1', 02:06:51 INFO - 'NO_EM_RESTART': '1', 02:06:51 INFO - 'PAGER': '/bin/cat', 02:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:51 INFO - 'PWD': '/builds/slave/test', 02:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:51 INFO - 'SHELL': '/bin/bash', 02:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:51 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:51 INFO - 'USER': 'cltbld', 02:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:51 INFO - 'XPC_FLAGS': '0x0', 02:06:51 INFO - 'XPC_SERVICE_NAME': '0', 02:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:55 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 02:06:55 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 02:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:55 INFO - Downloading docopt-0.6.1.tar.gz 02:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:55 INFO - Running setup.py install for blobuploader 02:06:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:55 INFO - Running setup.py install for requests 02:06:56 INFO - Running setup.py install for docopt 02:06:56 INFO - Successfully installed blobuploader requests docopt 02:06:56 INFO - Cleaning up... 02:06:56 INFO - Return code: 0 02:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:56 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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:06:56 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 02:06:56 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 02:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:56 INFO - 'HOME': '/Users/cltbld', 02:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:56 INFO - 'LOGNAME': 'cltbld', 02:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:56 INFO - 'MOZ_NO_REMOTE': '1', 02:06:56 INFO - 'NO_EM_RESTART': '1', 02:06:56 INFO - 'PAGER': '/bin/cat', 02:06:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:56 INFO - 'PWD': '/builds/slave/test', 02:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:56 INFO - 'SHELL': '/bin/bash', 02:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:06:56 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:56 INFO - 'USER': 'cltbld', 02:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:56 INFO - 'XPC_FLAGS': '0x0', 02:06:56 INFO - 'XPC_SERVICE_NAME': '0', 02:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-nvd9aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:56 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Sq1ajj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-XRPLxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-g1dr5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KwI7Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ic8iZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-nBcEYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-dc68Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-4Gtqwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-fEH5UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-jJqhcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:57 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hdg6Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:58 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-9irPrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-L2JbPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-jqt9EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-SJrCoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-y1M1sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:58 INFO - Running setup.py install for manifestparser 02:06:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Running setup.py install for mozcrash 02:06:58 INFO - Running setup.py install for mozdebug 02:06:59 INFO - Running setup.py install for mozdevice 02:06:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozfile 02:06:59 INFO - Running setup.py install for mozhttpd 02:06:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozinfo 02:06:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozInstall 02:06:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozleak 02:06:59 INFO - Running setup.py install for mozlog 02:07:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Running setup.py install for moznetwork 02:07:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Running setup.py install for mozprocess 02:07:00 INFO - Running setup.py install for mozprofile 02:07:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Running setup.py install for mozrunner 02:07:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:00 INFO - Running setup.py install for mozscreenshot 02:07:00 INFO - Running setup.py install for moztest 02:07:01 INFO - Running setup.py install for mozversion 02:07:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:01 INFO - Cleaning up... 02:07:01 INFO - Return code: 0 02:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:01 INFO - 'HOME': '/Users/cltbld', 02:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:01 INFO - 'LOGNAME': 'cltbld', 02:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:01 INFO - 'MOZ_NO_REMOTE': '1', 02:07:01 INFO - 'NO_EM_RESTART': '1', 02:07:01 INFO - 'PAGER': '/bin/cat', 02:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:01 INFO - 'PWD': '/builds/slave/test', 02:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:01 INFO - 'SHELL': '/bin/bash', 02:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:07:01 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:01 INFO - 'USER': 'cltbld', 02:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:01 INFO - 'XPC_FLAGS': '0x0', 02:07:01 INFO - 'XPC_SERVICE_NAME': '0', 02:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-4HTKD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-mmG6lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-AYzxre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KK9N9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:01 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-LqgGIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:02 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)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-RY8tj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:02 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)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-9mjpGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-EP4oF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-KMJrJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-8xezkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-xI2cut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-f5vvMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hgxFWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:02 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-me_MG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:03 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-B10N4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:03 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)) 02:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:03 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-uQ4skT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:03 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-zQzkpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:06 INFO - Downloading blessings-1.6.tar.gz 02:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:06 INFO - Installing collected packages: blessings 02:07:06 INFO - Running setup.py install for blessings 02:07:06 INFO - Successfully installed blessings 02:07:06 INFO - Cleaning up... 02:07:06 INFO - Return code: 0 02:07:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:06 INFO - Reading from file tmpfile_stdout 02:07:06 INFO - Current package versions: 02:07:06 INFO - blessings == 1.6 02:07:06 INFO - blobuploader == 1.2.4 02:07:06 INFO - docopt == 0.6.1 02:07:06 INFO - functools32 == 3.2.3-2 02:07:06 INFO - jsonschema == 2.5.1 02:07:06 INFO - manifestparser == 1.1 02:07:06 INFO - mozInstall == 1.12 02:07:06 INFO - mozcrash == 1.0 02:07:06 INFO - mozdebug == 0.1 02:07:06 INFO - mozdevice == 0.49 02:07:06 INFO - mozfile == 1.2 02:07:06 INFO - mozhttpd == 0.7 02:07:06 INFO - mozinfo == 0.9 02:07:06 INFO - mozleak == 0.1 02:07:06 INFO - mozlog == 3.4 02:07:06 INFO - moznetwork == 0.27 02:07:06 INFO - mozprocess == 0.24 02:07:06 INFO - mozprofile == 0.28 02:07:06 INFO - mozrunner == 6.13 02:07:06 INFO - mozscreenshot == 0.1 02:07:06 INFO - mozsystemmonitor == 0.3 02:07:06 INFO - moztest == 0.8 02:07:06 INFO - mozversion == 1.4 02:07:06 INFO - psutil == 3.1.1 02:07:06 INFO - requests == 1.2.3 02:07:06 INFO - wsgiref == 0.1.2 02:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:07 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')]} 02:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 02:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 02:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:07 INFO - 'HOME': '/Users/cltbld', 02:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:07 INFO - 'LOGNAME': 'cltbld', 02:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:07 INFO - 'MOZ_NO_REMOTE': '1', 02:07:07 INFO - 'NO_EM_RESTART': '1', 02:07:07 INFO - 'PAGER': '/bin/cat', 02:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:07 INFO - 'PWD': '/builds/slave/test', 02:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:07 INFO - 'SHELL': '/bin/bash', 02:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:07:07 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:07 INFO - 'USER': 'cltbld', 02:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:07 INFO - 'XPC_FLAGS': '0x0', 02:07:07 INFO - 'XPC_SERVICE_NAME': '0', 02:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:07:07 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)) 02:07:07 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)) 02:07:07 INFO - Cleaning up... 02:07:07 INFO - Return code: 0 02:07:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:07 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')]} 02:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:07 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')]} 02:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:08 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 0x10bc80b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8cb57c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, '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.WolNqTgU9D/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.TkPcbIDcEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 02:07:08 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 02:07:08 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 02:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:08 INFO - 'HOME': '/Users/cltbld', 02:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:08 INFO - 'LOGNAME': 'cltbld', 02:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:08 INFO - 'MOZ_NO_REMOTE': '1', 02:07:08 INFO - 'NO_EM_RESTART': '1', 02:07:08 INFO - 'PAGER': '/bin/cat', 02:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:08 INFO - 'PWD': '/builds/slave/test', 02:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:08 INFO - 'SHELL': '/bin/bash', 02:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:07:08 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:08 INFO - 'USER': 'cltbld', 02:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:08 INFO - 'XPC_FLAGS': '0x0', 02:07:08 INFO - 'XPC_SERVICE_NAME': '0', 02:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:07:08 INFO - Cleaning up... 02:07:08 INFO - Return code: 0 02:07:08 INFO - Running post-action listener: _resource_record_post_action 02:07:08 INFO - Running post-action listener: _start_resource_monitoring 02:07:08 INFO - Starting resource monitoring. 02:07:08 INFO - [mozharness: 2017-02-03 10:07:08.427223Z] Finished create-virtualenv step (success) 02:07:08 INFO - [mozharness: 2017-02-03 10:07:08.428175Z] Running install step. 02:07:08 INFO - Running pre-action listener: _resource_record_pre_action 02:07:08 INFO - Running main action method: install 02:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:08 INFO - Reading from file tmpfile_stdout 02:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:08 INFO - Reading from file tmpfile_stdout 02:07:08 INFO - Output received: 02:07:08 INFO - Usage: mozinstall [options] installer 02:07:08 INFO - Options: 02:07:08 INFO - -h, --help show this help message and exit 02:07:08 INFO - -d DEST, --destination=DEST 02:07:08 INFO - Directory to install application into. [default: 02:07:08 INFO - "/builds/slave/test"] 02:07:08 INFO - --app=APP Application being installed. [default: firefox] 02:07:08 INFO - mkdir: /builds/slave/test/build/application 02:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:07:28 INFO - Reading from file tmpfile_stdout 02:07:28 INFO - Output received: 02:07:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:07:28 INFO - Running post-action listener: _resource_record_post_action 02:07:28 INFO - [mozharness: 2017-02-03 10:07:28.810466Z] Finished install step (success) 02:07:28 INFO - [mozharness: 2017-02-03 10:07:28.810641Z] Running run-tests step. 02:07:28 INFO - Running pre-action listener: _resource_record_pre_action 02:07:28 INFO - Running main action method: run_tests 02:07:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:07:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:07:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:07:28 INFO - 2017-02-03 02:07:28.825 screenresolution[1621:7417] starting screenresolution argv=screenresolution get 02:07:28 INFO - 2017-02-03 02:07:28.827 screenresolution[1621:7417] Display 0: 1600x1200x32@60 02:07:28 INFO - 2017-02-03 02:07:28.833 screenresolution[1622:7419] starting screenresolution argv=screenresolution list 02:07:28 INFO - Available Modes on Display 0 02:07:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:07:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:07:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:07:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:07:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:07:29 INFO - Intel Iris: 02:07:29 INFO - Chipset Model: Intel Iris 02:07:29 INFO - Type: GPU 02:07:29 INFO - Bus: Built-In 02:07:29 INFO - VRAM (Dynamic, Max): 1536 MB 02:07:29 INFO - Vendor: Intel (0x8086) 02:07:29 INFO - Device ID: 0x0a2e 02:07:29 INFO - Revision ID: 0x0009 02:07:29 INFO - Displays: 02:07:29 INFO - Display: 02:07:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:07:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:07:29 INFO - Display Serial Number: 1600x1200 60 02:07:29 INFO - Main Display: Yes 02:07:29 INFO - Mirror: Off 02:07:29 INFO - Online: Yes 02:07:29 INFO - Rotation: Supported 02:07:29 INFO - Return code: 0 02:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:29 INFO - Python 2.7.3 02:07:29 INFO - Return code: 0 02:07:29 INFO - grabbing minidump binary from tooltool 02:07:29 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')]} 02:07:29 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 0x10ba5ed30>, '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 0x10b985db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba53be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:29 INFO - Return code: 0 02:07:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:07:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:07:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:29 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/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 02:07:29 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/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --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 02:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WolNqTgU9D/Render', 02:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:07:29 INFO - 'HOME': '/Users/cltbld', 02:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:07:29 INFO - 'LOGNAME': 'cltbld', 02:07:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:29 INFO - 'MOZ_NO_REMOTE': '1', 02:07:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:29 INFO - 'NO_EM_RESTART': '1', 02:07:29 INFO - 'PAGER': '/bin/cat', 02:07:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:29 INFO - 'PWD': '/builds/slave/test', 02:07:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:07:29 INFO - 'SHELL': '/bin/bash', 02:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TkPcbIDcEY/Listeners', 02:07:29 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 02:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:07:29 INFO - 'USER': 'cltbld', 02:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:29 INFO - 'XPC_FLAGS': '0x0', 02:07:29 INFO - 'XPC_SERVICE_NAME': '0', 02:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:07:29 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/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 02:07:29 INFO - mozversion application_buildid: 20170203004018 02:07:29 INFO - mozversion application_changeset: ed726703c08c7a0398d349efaded8bdea25c46ff 02:07:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:07:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:29 INFO - mozversion application_name: Firefox 02:07:29 INFO - mozversion application_remotingname: firefox-dev 02:07:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:29 INFO - mozversion application_vendor: Mozilla 02:07:29 INFO - mozversion application_version: 53.0a2 02:07:29 INFO - mozversion platform_buildid: 20170203004018 02:07:29 INFO - mozversion platform_changeset: ed726703c08c7a0398d349efaded8bdea25c46ff 02:07:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:07:29 INFO - mozversion platform_version: 53.0a2 02:07:29 INFO - using testdate: 1486116449 02:07:29 INFO - actual date: 1486116449 02:07:29 INFO - starting webserver on 'localhost:49242' 02:07:29 INFO - SUITE-START | Running 2 tests 02:07:29 INFO - TEST-START | dromaeo_css 02:07:29 INFO - operating with platform_type : mac_ 02:07:29 INFO - Initialising browser for dromaeo_css test... 02:07:29 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpcOwCf4/profile http://localhost:49242/getInfo.html) 02:07:32 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 02:07:32 INFO - PROCESS | 1632 | colorDepth:24 02:07:32 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 02:07:32 INFO - PROCESS | 1632 | __metrics 02:07:32 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:07:32 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:32 INFO - TEST-INFO | 1632: exit 0 02:07:32 INFO - Browser initialized. 02:07:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:32 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpcOwCf4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:44 INFO - PROCESS | 1635 | RSS: Main: 212742144 02:07:44 INFO - PROCESS | 1635 | 02:10:48 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 02:10:50 INFO - PROCESS | 1635 | RSS: Main: 342700032 02:10:50 INFO - PROCESS | 1635 | 02:12:34 INFO - PROCESS | 1635 | ************************* 02:12:34 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 02:12:34 INFO - PROCESS | 1635 | 02:12:34 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:12:34 INFO - PROCESS | 1635 | Full stack: 02:12:34 INFO - PROCESS | 1635 | ************************* 02:13:53 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 02:13:53 INFO - PROCESS | 1635 | RSS: Main: 347623424 02:13:53 INFO - PROCESS | 1635 | 02:16:56 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 02:16:56 INFO - PROCESS | 1635 | RSS: Main: 327483392 02:16:56 INFO - PROCESS | 1635 | 02:19:59 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 02:20:00 INFO - PROCESS | 1635 | RSS: Main: 339705856 02:20:00 INFO - PROCESS | 1635 | 02:23:03 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 02:23:04 INFO - PROCESS | 1635 | RSS: Main: 309227520 02:23:04 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 02:26:07 INFO - PROCESS | 1635 | RSS: Main: 518352896 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | __start_tp_report 02:26:07 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 02:26:07 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 02:26:07 INFO - PROCESS | 1635 | |i|pagename|runs| 02:26:07 INFO - PROCESS | 1635 | |0;dojo.html;3313.3373325334937;3313.7183339416147;3326.6839650233233;3359.428897087495;3376.5312089241183;5644.04051311277;5715.9428405715935;5729.111987641912;5741.569382296334;5749.108888122342;5701.6864072476;5781.508571771394;5783.681897495636;5792.102224155252;5819.825405237839;5245.029669511134;5269.156934890409;5278.815241466549;5282.894342113155;5334.759935802879;4139.275626765319;4956.190990288536;5176.12005958986;5177.223416487519;5356.812511562096;5244.318238628973;5271.024860400819;5275.577953763709;5277.076511610453;5280.181571856349;5294.10000299948;5294.258803767476;5295.28513650658;5298.947010529884;5302;5147;5250.65870718402;5252;5252.36971563411;5287.4448182941005;5823.010088285002;5836.066229403275;5837.795677151279;5840.88318233633;5847.795327163529;6158.969205153946;6190.288116866573;6200.410960958701;6202.596831205957;6203.720832562545;6287.434130928193;6298.2756982947085;6319.462845658125;6326.43062124411;6327.651979141146;5122.615803814729;5823.941760582382;5825.970870145665;5826.9708651456895;5882.000059989812;6187.84530386735;6233.563650544418;6246.6876656167005;6287.2769631492965;6296.937030629727;6118.80192544137;6159.798839226398;6178.165947597106;6228.283747369111;6233.189685340877;6295.6537390443045;6320.241571011508;6322.525810564226;6325.430711235919;6328.177336946167;6135.601185922901;6291.591046582049;6302.243730752339;6308.0537919311555;6309.652969086745;6138.296437970408;6169.475594574512;6221.160143380585;6227.034809604518;6233.252009758858;5010.423801262901;5010.974945125251;5017.397912250481;5028.296038554606;5042.420121686053;4464.933026004613;4466.260854801564;4472.9552704472535;4493.213687604656;4493.820247190141;5626.1842032905;5666.660000399989;5677.460641239076;5722.828315150552;5735.598508104476;6254.312025677172;6293.96853015732;6316.336784637639;6319.557630965788;6325.683715814191;5774.162746401748;5792.94207057924;5799.710014499258;5803.216565763568;5846.590738648254;5357.19642053695;5357.812476563379;5474.124140137559;5482.5613950883835;5502.147167189092;6232.470240029467;6252.468540173954;6261.217347831612;6291.622502649856;6295.496360291074;6192.504599631929;6251.218597675291;6254.530910181846;6256.874862502634;6313.05304204373;6274.811755647338;6276.8430789228805;6288.496920246461;6349.746010159542;6362.854686156536;6164.260288765377;6258.780942666985;6270;6283.3716628338625;6283.560150789401;5168.8449346519665;5539.279893613804;6000.609960352563;6147.938520614736;6241.500679945502;5947.434993675594;6162.383761623802;6174.228221472316;6177.413145751147;6207.472364849038;6175.475084617858;6189.907151392823;6190;6197.907031394623;6208.130861679459;5826.067829147316;5845.3570107289015;5936.732847021981;5958.970205148947;6047.637141771508;6101.5188887447375;6130.520435899211;6157.630542167484;6160.969195153995;6169.2288463942;5921.733521991435;5928.911066334094;6019.097135429721;6024.096385542029;6028.6985650716415 02:26:07 INFO - PROCESS | 1635 | |1;ext.html;469.76511744127936;473.3846000199742;492.5566989709261;495.6431369414023;499.23866104191103;31588.68411315889;37938.861834144984;42272.78863605678;42302.94242643932;44101.11797764043;43230.13539729203;43633.34549981753;43637;43726;43789.56210437902;9202.309826762987;9460.8580871287;9469.147776700096;9471.952640236788;9490.240780737558;8365.456245344034;8572.571371431435;9359.6724114656;11380;11410.657680269564;11307;11338.376389298584;11398.658040258806;11431.485583148778;11436.828447573293;8394.24451799341;11295.887041129607;11376.317420954769;11424.42877856104;11427;8457.957710211409;8612.18184272493;8622.051574326819;8633.568321583896;11034.337939723642;39277;41416;41473.1705365894;41522.79238603818;41589;3063.8008529445515;3488.790672559629;3498.282852015356;3518.2611651552947;3650;28757;29369.412611747644;29378.55932161019;30295;30604.387912241855;3236.158598764315;3299.6040475142895;3361.966380336214;3408.608010078823;3408.829558522064;484858.5757071192;484942;486953;488702;488826.55586722196;61079.47301317414;62968;63259.6837015812;63292.36707632865;63534;64185;65883;65892.34107658862;65945.67027164834;65994.67002664956;16379.42672006498;16966;16999;17059.061751603782;17061.232244549024;11817.172797904235;12143.332116733487;13127.540536081382;13143.474261029452;13216.140950838164;13662;14905;15019.399224030916;15054.924725376522;15078.285908536349;6993.545419547713;7237.782866514013;7239;7292.744753933587;7301.342879140902;872.8385248729005;885.5173930208052;891.9554022298859;899.7975455522455;922.2760133295465;29961.101166965025;30149;30178.080554559772;30206.395872082874;30425.935092272106;1051.2536099369381;1067.7063807453012;1079.3901445683164;1088.678839742278;1111.927724697892;15446.382144714085;15459.690806184039;15497.302621382065;15615.765763513557;15936.601584960237;550624;554208;555132;556870;557690.4230957639;59609.40390596038;59731;59782;59827.70086149542;59850;1440.5750303660445;1455.6069861137435;1467.8091848059685;1472.2123663839795;1477.6084337650746;27479.86260068687;29432.11703648894;29605.407891842475;30255.579553635216;30272.84863575668;50131.49868501268;50397.74801125971;50625;50635.493645064555;50718.492815071375;543429.282853599;548757;548883;549554;549728;39056;40037.59962400455;40140.197196055335;40476.190476189724;40542.79728601338;43755.56244437515;46638.53361466342;46648.06703865971;46883;47001.29498057463;37319.06702332355;37834.81082594569;38361.040973975876;38768.61231387763;39464.80267598759;37958.810205948794;38194;38698.22603547857;38933.8053309743;39174.216515670094;35109.47335789914;36365.72719954789;37449.6255037457;38280.42579361368;38293.61706383012;31744.841275793475;33403.498947516295;33406.49890251697;33470;33495.33009339751;23754;24048.038078477366;24525.773711314007;24918.626220606344;25346.873265633552 02:26:07 INFO - PROCESS | 1635 | |2;jquery.html;359.49849959306766;362.5866512176118;390.90227443139213;402.5290410220043;426.8079364286072;15254.618634534128;15465.994710343834;18843.62312753746;20920.37238882832;21623.891880540614;20309.796902030976;20498.176734838034;20823.895880520613;22068.668969965463;22617.434564135903;5846.801405711819;5877.823665290048;5987.042073268278;6019.909701354483;6027.72875220614;6005.00917348637;6028.909566356509;6076.210092687967;6078.574499784994;6085.056816193497;4191.790410479479;4425.77871106445;4449.021215332622;6658.400743933069;6757.763478278262;6488;6714.865702685944;6721.260661327299;6732.057511948331;6755.121834161552;5805.36141024487;5866.823995280149;5877.030290002144;5893.852653683649;5907.527397808208;27149.864250678816;27179.184624461297;27482;27552.724472755417;27623.171304860887;2802.621646077794;2821.901233456819;2834.5039618066758;2848.757855582278;2859.042220856016;15510.767338489932;16007.359705611761;16082.839171608251;16249.431269905497;16528;1756.5081777102432;1847.2132129135218;1853.9907300463547;1855.554666879939;1871.6163186546726;101804;112543.43728281389;137990;143511.28244358712;143581;11149.275297105662;11917.106217033757;12036.759264814655;12123.636290911287;12136.696582585506;16017.359305627877;16030.919845400931;16052;16069.919650401907;16120.516384508484;8579.82840343202;9015.323850711224;9025.104728007193;9116.680916167903;9133.77165570866;8877;8883.73348799537;8890.822183556293;9030.45817250967;9053.230475409533;4866.515712707587;4872.1473742094995;4878.926816097762;4879.316895634614;4947.48051454592;1664.3093116356577;1715.9618430849407;1996.5807180491968;2025.6225766478642;2026.7466566679166;988.2785566536469;1002.9097381235724;1008.178334657252;1017.9083882450615;1026.2149455666422;20811.271605493734;21168.941552922293;21197.25809596657;21318.680219796715;21399.45517090518;784.2980532423448;993.8707967964118;1023.902729240721;1030.7114008077751;1041.8645576075214;10130.936251693465;10773.784524309627;10959.06847917936;11030.117590592734;11043.558257669763;724143;733126;738708;741701;752281;137280;138308;143058;145268;147642.26178869038;889.4574309671095;961.3847137831793;978.5938835383379;1017.8422344536609;1020.9489525523694;18464.261429543207;19437.8056219436;20208.79791202069;20556;20626.071826767533;57806;58527.12209316949;59681.701591493504;60481.48796280128;61504.69247653733;62240.688796555725;76608.23391766011;80435;81973;90031.8488852887;8356.791080223044;8370.58147092655;8373.07896131413;8748.950125984922;8964.91035089667;12070.637880863587;12828.29444380568;13556.05107642495;13738.65653358674;13976.860231397555;11129.054030407506;11397.373144476802;11505.827412588651;11898.702532436759;11957.461914213707;11047.447627618747;11497.94251028773;11532.502324093442;11798;11955.880441195477;6167.876642467215;9644.9035509644;9682.644429779977;10112.797744045225;11387.487563059516;8411.83176336482;8514;8640.697575584825;8641.82716345657;9008.684696035607;9571.425714457155;11153.107751379708;11400.087992960378;11898.22661526998;11996.58011969577 02:26:07 INFO - PROCESS | 1635 | |3;mootools.html;1283.8395200599925;1430.9212993285364;1432.4341884955443;1452.912825230487;1454.1057249791381;7973.521588704674;8382.622781974811;8389.87415188771;8390.91609083909;8400.621972011259;7312.305330993547;7607.125180604232;7613.162552119263;7920.445568810185;8172.305354044914;2241.6413373860146;2296.01271453275;2301.2175860207526;2303.8272129590264;2304.608216603173;1995.6108558831033;2308.088305119477;2343.9062437502566;2354.764523547649;2357.1514254868234;2043.632146213681;2112.7887211278826;2235.441139715071;2285.1887579909144;2318.4899322149186;2294.8508346957396;2297.781710737469;2300.229423143249;2305.7578954209903;2308.3882771065682;2051.476873397289;2150.354893531934;2289.8168146548237;2329.5108027314286;2329.5457385809773;8290.29532489733;8357.874631880526;8370;8389.706360277421;8418;5015.072211640858;5178.575891629832;5182;5185.040767457995;5207.244949482341;3279.212988882651;3406.863725450979;3516.085817687394;3517.2262102337445;3522.348365552381;1144.2733863996339;1212.9150959432843;1248.5442813373054;1309.3453273363318;1760.119940029985;10734.409607471585;10737.355758654428;10838.837417438823;10852.837207441895;10861.83707244392;4324.35134729793;4457.353683715843;4518.186726389215;4529.796159172845;4539.886502837389;8638.17937295956;8665.35009874262;8677.739667809976;8679.739607811649;8681.2186903179;5111.616628752859;5114.64197506171;5121.641485096082;5123.205903085028;5133.974330128325;4263.445752052214;4434.002349471343;4507.977460112678;4757.429108507002;4768.380110585602;3685.3366394048794;3709.573399059143;3773.735838491279;3818.904527386782;3825.9617403826164;1148.4774427635407;1153.9365334906493;1162.6395817296666;1172.5427083437467;1173.5129921082826;780.9140994490601;916.6654171227455;918.2195134135931;931.189864817613;950.3015283766426;5424.484673955968;5743.483086522233;5757.884842303214;5764.308283005982;5811.3316968548315;957.2963871554402;969.6654654144309;970.5195928015678;1011.9392836429838;1029.9330543514648;3648.3980143276062;3792.469054332396;3823.8719577724637;3922.9019274517796;3965.72239943207;9586.424814511152;9955.153811925922;10078.445685487368;10113.190944724405;10143.64497242593;9894.109530142321;9951.203903687687;9986.500674966223;10067;10083.991600839858;7713.961430192925;7822.765317040498;7842.960785196037;7938.04743430792;7990.840183196304;4879.487653796442;4940.851774446773;5364.463553644604;5448.45515448452;5482.23248745168;8999.415038022507;9140.405873618194;9171.495567743837;9277.350585458953;9399.154076133182;9265.166135047879;9318.767030824283;9347.252219822261;9410.153086222273;9501.667441639509;6287.088372186099;6505.121808555785;6508.284088750328;6727;6836.965815170893;7741.45809793309;7965.044194696674;7978.760637180661;8010.078840933134;8024.598770061591;6936.687849046906;7057.36483716468;7174.1032370953635;7239.321451063141;7313.378362839218;6454.709538070704;6897.482688798461;7031.296870312928;7143.285671432815;7184.748533801292;6110.877782444415;6372.330905255067;6478.060681201294;6478.384553467413;6480.416762491398;4965.900681986413;5006.824761133488;5011.799528018839;5012.47369026247;5032.572231360376;4871.415430148405;4977.701337919591;4999.725015124203;5106.183010718267;5173.32746742921 02:26:07 INFO - PROCESS | 1635 | |4;prototype.html;338.77132935268696;355.2149749054589;363.69086276664837;375.8590528551793;377.4489245701276;4529.728216307016;4746.62027037837;5098.847034588964;5158.6131040171995;5306.734663266836;4206.747595144286;4881.900782663453;5080.415752188499;5191.740412979346;5229.940484816378;3204.221656980375;3476.974292583694;3547.467879818022;3790.4459171739522;3924.54867690215;3271.6401195868552;3686.8525258989607;3982.860599879005;3983.6016398360075;4029.858954936578;3498.667626575484;3964.709291288224;3965.325894597925;3966.8214930328204;4003.15933653933;3514.6485351464776;3581.3553560359255;3986.222686576119;4013.8795836124964;4022.879313620596;3267.3628642414737;3304.653011433789;3439.7592168548213;3463.2727127303046;3465.203003309253;4513.819447222108;5114.411842638107;5126.000859664734;5139.486051394831;5144.922826157611;4458.4426946631675;4537.251353526664;4539.364488971547;4572.262540234689;4576.954230457686;4941.827036053721;5318.468153184689;5484.8354549363585;5570.2480165177585;5581.939431508001;3601.8559257629663;3803.2124901296347;3810.79040652764;3816.263600061965;3826.8660596879254;5561.694106824123;5816.8836623267725;5837.67892765902;5838.678872662002;5850.678212698257;3585.8386372613295;3731.981340093282;3835.1562656215588;3846.1730727893637;3881.5342158941107;3273.2798784267425;3866.4586957825927;3914.8825535233987;3919.2553414851086;3937.9803100984313;3767.1523907120677;4553.042191857467;4566.840160594364;4568.954310456853;4575.542445755398;4914.336564563738;5396.595255355864;5632.52123569493;5650.604457688005;5668.234788303609;1113.8162203236536;1263.412513181375;1264.5953294945714;1268;1269.695273134441;646.1954866191528;793.5238856686058;830.1988581019225;838.4256784102909;842.3093063687717;4331.501877284152;4787.0904528139545;4958.9832235888325;4965.702057876539;5116.286044175168;5261.579073674174;5525.889482210333;5573.777048918079;5593.440655934455;5598.440155984369;4703.717776933395;4746.311784791186;5067.3412456381175;5111.642185047011;5297.947020529746;2619.64634774303;2841.0414508542767;2871;2883.812552184101;2911.7233862783;5277.656952298088;5323.813666521653;5335.306410166653;5653.519450846642;5739.13912913058;4972.916791589238;4975.4278258000795;5286.8942621148135;5631.633943793722;5679.716014199356;4710.3405523226775;5197.870053248624;5329.173978033411;5660.660360378391;5705.94440028596;4823.734694591831;5011.423686275979;5340.759665815125;5504.9174262385295;5521.668699878021;4598.724076555417;4627.768611569475;5086.262491938722;5458.4541545845095;5544.279243698294;4820.4456487504385;5652.943470565242;5693.402192769865;5732.713364331683;5747.511461525817;3426.8629254830525;3617.385044542487;3925.3326934420647;3962.3264045111823;3975.4159796132744;5112.948870511247;5328.973355133355;5422.827645827235;5474.370447398441;5497.697626630414;5381.434949330264;5595.972020139873;5608.831735047955;5636.2245892543715;5639.6334238274385;4611.308303754464;4696.906061878812;5360.839174824761;5607.859803504945;5636.464535869086;5286.603504737083;5459.645123066988;5512.448755124456;5526.309211348582;5551.750171242223;5332.440093790251;5338.304156400993;5572.916406253828;5579;5604.635698679573;4759.333693282874;5275.419703832652;5379.892402151857;5474.671519708831;5510.0632892409185 02:26:07 INFO - PROCESS | 1635 | |5;yui.html;714.0752725220842;775.4881778026501;827.571078883477;829.5852073963018;838.1157878438249;15517.689646207084;16119.677606447864;16158;16197.83802161978;16198.838011619895;14678.85321146791;14840;14846.55460336189;14850.554483365517;14871.182084985321;700.0549258501034;717.2468907646976;719.6293908637056;872.2237208884098;875.6541166239332;894.4454438248296;896.551724137931;913.127962795532;913.8446464101086;916.4180745226762;944.6929747831948;947.554649314821;949.852772820214;950.4487397309579;952.1716106986931;732.2969948849058;760.2967255288836;945.8533927241255;946.5551190940247;946.8153710026513;684.6816230452863;701.5439964023375;707.3527722134241;709.3722055980443;712.3268511256813;15014.774778378332;15377.538673839803;15404.229788510529;15449.691006179813;15453.690926181413;12305.692357691129;14106.858931410658;14110.365033573515;14114.92942535291;14127.505537306248;12445.191062580903;12607.684807879785;12615.306158161298;12780.872191278062;12965.546205882749;4258.787060646986;4378.562143785628;4442.489113751928;4595.655325850541;4629.097326021427;102380;103260.48369758103;106032.22854971545;108094.37858432208;112109.43945280302;10856.891431085745;11050.668479945614;11115.44422778874;11220.046296064926;11673.299602023906;22782.886085569466;22798.430039249153;22803.771962280498;22810.20164294242;22820;7520.435967302475;7627.0847498299445;7728.072631284282;7743;7920.841583168304;4134.235166494208;4261.403403523447;4335.176316499855;4357.869263922087;4417.160739459492;3503.649635036476;3609.7653652512504;3614.2590768892314;3615.94576081359;3616.72874534411;633.9429451349308;647.1942431672597;650.5056157320375;657.7204688007578;666.5600703535644;639.335091504839;644.4328990488434;648.5654611410366;648.8994205898093;685.8971154326791;8537.402381833212;9765.853512197322;9836.606535738634;9873.555689993967;10094.798104037878;574.3739324136711;616.7748771698388;651.9419969180921;666.8632930249287;690.9032735417046;4590;4876.146674331978;4894;4896.681715688469;4902.754862256944;89782;103038;104489.95510044802;107123.46438267759;109815;86657;88018;88317;90681;90909;59278;62393.68803155955;69602.9559556597;79032;85430.14569854346;9731.805363892825;10662.200334974752;11041.227114101936;11416.600418985296;11428.657140285804;49775;50465;50885.236721449946;51901.480985189664;52766;64377.678111611014;65458.672706636164;66450;67214.66392668005;68813;13119.27843968591;13598.184108953494;13858.722825543231;14244.473484152055;14260.572182834532;14541;14589.781153282496;15094;15345.309461074501;15706.842931570538;13510.797338040134;13579.728405432033;14082.929585352418;14193.787093193818;14270.857291426953;13302.334883255991;13927.930360348133;14096.577102686935;14107.435702571782;14175.432982680577;12815.16701414405;13688.726225475633;13713.931430342784;13845.030847840555;13878.23669698136;9934.751631209278;11257.324560526395;11488.253263537843;11516.94241528787;11723.35029145219;9719.951400242953;9811.656592019244;10277.588896444058;10986.395748233925;11008.944955275172 02:26:07 INFO - PROCESS | 1635 | __end_tp_report 02:26:07 INFO - PROCESS | 1635 | __start_cc_report 02:26:07 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1285 02:26:07 INFO - PROCESS | 1635 | __end_cc_report 02:26:07 INFO - PROCESS | 1635 | __startTimestamp1486117567283__endTimestamp 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | ------- Summary: start ------- 02:26:07 INFO - PROCESS | 1635 | Number of tests: 6 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5761.80 Median:5947.43 stddev:649.13 (10.9%) stddev-sans-first:622.05 02:26:07 INFO - PROCESS | 1635 | Values: 3313.3 3313.7 3326.7 3359.4 3376.5 5644.0 5715.9 5729.1 5741.6 5749.1 5701.7 5781.5 5783.7 5792.1 5819.8 5245.0 5269.2 5278.8 5282.9 5334.8 4139.3 4956.2 5176.1 5177.2 5356.8 5244.3 5271.0 5275.6 5277.1 5280.2 5294.1 5294.3 5295.3 5298.9 5302.0 5147.0 5250.7 5252.0 5252.4 5287.4 5823.0 5836.1 5837.8 5840.9 5847.8 6159.0 6190.3 6200.4 6202.6 6203.7 6287.4 6298.3 6319.5 6326.4 6327.7 5122.6 5823.9 5826.0 5827.0 5882.0 6187.8 6233.6 6246.7 6287.3 6296.9 6118.8 6159.8 6178.2 6228.3 6233.2 6295.7 6320.2 6322.5 6325.4 6328.2 6135.6 6291.6 6302.2 6308.1 6309.7 6138.3 6169.5 6221.2 6227.0 6233.3 5010.4 5011.0 5017.4 5028.3 5042.4 4464.9 4466.3 4473.0 4493.2 4493.8 5626.2 5666.7 5677.5 5722.8 5735.6 6254.3 6294.0 6316.3 6319.6 6325.7 5774.2 5792.9 5799.7 5803.2 5846.6 5357.2 5357.8 5474.1 5482.6 5502.1 6232.5 6252.5 6261.2 6291.6 6295.5 6192.5 6251.2 6254.5 6256.9 6313.1 6274.8 6276.8 6288.5 6349.7 6362.9 6164.3 6258.8 6270.0 6283.4 6283.6 5168.8 5539.3 6000.6 6147.9 6241.5 5947.4 6162.4 6174.2 6177.4 6207.5 6175.5 6189.9 6190.0 6197.9 6208.1 5826.1 5845.4 5936.7 5959.0 6047.6 6101.5 6130.5 6157.6 6161.0 6169.2 5921.7 5928.9 6019.1 6024.1 6028.7 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:67452.47 Median:38851.21 stddev:141326.40 (363.8%) stddev-sans-first:141633.38 02:26:07 INFO - PROCESS | 1635 | Values: 469.8 473.4 492.6 495.6 499.2 31588.7 37938.9 42272.8 42302.9 44101.1 43230.1 43633.3 43637.0 43726.0 43789.6 9202.3 9460.9 9469.1 9472.0 9490.2 8365.5 8572.6 9359.7 11380.0 11410.7 11307.0 11338.4 11398.7 11431.5 11436.8 8394.2 11295.9 11376.3 11424.4 11427.0 8458.0 8612.2 8622.1 8633.6 11034.3 39277.0 41416.0 41473.2 41522.8 41589.0 3063.8 3488.8 3498.3 3518.3 3650.0 28757.0 29369.4 29378.6 30295.0 30604.4 3236.2 3299.6 3362.0 3408.6 3408.8 484858.6 484942.0 486953.0 488702.0 488826.6 61079.5 62968.0 63259.7 63292.4 63534.0 64185.0 65883.0 65892.3 65945.7 65994.7 16379.4 16966.0 16999.0 17059.1 17061.2 11817.2 12143.3 13127.5 13143.5 13216.1 13662.0 14905.0 15019.4 15054.9 15078.3 6993.5 7237.8 7239.0 7292.7 7301.3 872.8 885.5 892.0 899.8 922.3 29961.1 30149.0 30178.1 30206.4 30425.9 1051.3 1067.7 1079.4 1088.7 1111.9 15446.4 15459.7 15497.3 15615.8 15936.6 550624.0 554208.0 555132.0 556870.0 557690.4 59609.4 59731.0 59782.0 59827.7 59850.0 1440.6 1455.6 1467.8 1472.2 1477.6 27479.9 29432.1 29605.4 30255.6 30272.8 50131.5 50397.7 50625.0 50635.5 50718.5 543429.3 548757.0 548883.0 549554.0 549728.0 39056.0 40037.6 40140.2 40476.2 40542.8 43755.6 46638.5 46648.1 46883.0 47001.3 37319.1 37834.8 38361.0 38768.6 39464.8 37958.8 38194.0 38698.2 38933.8 39174.2 35109.5 36365.7 37449.6 38280.4 38293.6 31744.8 33403.5 33406.5 33470.0 33495.3 23754.0 24048.0 24525.8 24918.6 25346.9 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:40158.79 Median:27164.52 stddev:122555.09 (451.2%) stddev-sans-first:122862.45 02:26:07 INFO - PROCESS | 1635 | Values: 359.5 362.6 390.9 402.5 426.8 15254.6 15466.0 18843.6 20920.4 21623.9 20309.8 20498.2 20823.9 22068.7 22617.4 5846.8 5877.8 5987.0 6019.9 6027.7 6005.0 6028.9 6076.2 6078.6 6085.1 4191.8 4425.8 4449.0 6658.4 6757.8 6488.0 6714.9 6721.3 6732.1 6755.1 5805.4 5866.8 5877.0 5893.9 5907.5 27149.9 27179.2 27482.0 27552.7 27623.2 2802.6 2821.9 2834.5 2848.8 2859.0 15510.8 16007.4 16082.8 16249.4 16528.0 1756.5 1847.2 1854.0 1855.6 1871.6 101804.0 112543.4 137990.0 143511.3 143581.0 11149.3 11917.1 12036.8 12123.6 12136.7 16017.4 16030.9 16052.0 16069.9 16120.5 8579.8 9015.3 9025.1 9116.7 9133.8 8877.0 8883.7 8890.8 9030.5 9053.2 4866.5 4872.1 4878.9 4879.3 4947.5 1664.3 1716.0 1996.6 2025.6 2026.7 988.3 1002.9 1008.2 1017.9 1026.2 20811.3 21168.9 21197.3 21318.7 21399.5 784.3 993.9 1023.9 1030.7 1041.9 10130.9 10773.8 10959.1 11030.1 11043.6 724143.0 733126.0 738708.0 741701.0 752281.0 137280.0 138308.0 143058.0 145268.0 147642.3 889.5 961.4 978.6 1017.8 1020.9 18464.3 19437.8 20208.8 20556.0 20626.1 57806.0 58527.1 59681.7 60481.5 61504.7 62240.7 76608.2 80435.0 81973.0 90031.8 8356.8 8370.6 8373.1 8749.0 8964.9 12070.6 12828.3 13556.1 13738.7 13976.9 11129.1 11397.4 11505.8 11898.7 11957.5 11047.4 11497.9 11532.5 11798.0 11955.9 6167.9 9644.9 9682.6 10112.8 11387.5 8411.8 8514.0 8640.7 8641.8 9008.7 9571.4 11153.1 11400.1 11898.2 11996.6 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5378.82 Median:5118.14 stddev:2924.85 (57.1%) stddev-sans-first:2916.86 02:26:07 INFO - PROCESS | 1635 | Values: 1283.8 1430.9 1432.4 1452.9 1454.1 7973.5 8382.6 8389.9 8390.9 8400.6 7312.3 7607.1 7613.2 7920.4 8172.3 2241.6 2296.0 2301.2 2303.8 2304.6 1995.6 2308.1 2343.9 2354.8 2357.2 2043.6 2112.8 2235.4 2285.2 2318.5 2294.9 2297.8 2300.2 2305.8 2308.4 2051.5 2150.4 2289.8 2329.5 2329.5 8290.3 8357.9 8370.0 8389.7 8418.0 5015.1 5178.6 5182.0 5185.0 5207.2 3279.2 3406.9 3516.1 3517.2 3522.3 1144.3 1212.9 1248.5 1309.3 1760.1 10734.4 10737.4 10838.8 10852.8 10861.8 4324.4 4457.4 4518.2 4529.8 4539.9 8638.2 8665.4 8677.7 8679.7 8681.2 5111.6 5114.6 5121.6 5123.2 5134.0 4263.4 4434.0 4508.0 4757.4 4768.4 3685.3 3709.6 3773.7 3818.9 3826.0 1148.5 1153.9 1162.6 1172.5 1173.5 780.9 916.7 918.2 931.2 950.3 5424.5 5743.5 5757.9 5764.3 5811.3 957.3 969.7 970.5 1011.9 1029.9 3648.4 3792.5 3823.9 3922.9 3965.7 9586.4 9955.2 10078.4 10113.2 10143.6 9894.1 9951.2 9986.5 10067.0 10084.0 7714.0 7822.8 7843.0 7938.0 7990.8 4879.5 4940.9 5364.5 5448.5 5482.2 8999.4 9140.4 9171.5 9277.4 9399.2 9265.2 9318.8 9347.3 9410.2 9501.7 6287.1 6505.1 6508.3 6727.0 6837.0 7741.5 7965.0 7978.8 8010.1 8024.6 6936.7 7057.4 7174.1 7239.3 7313.4 6454.7 6897.5 7031.3 7143.3 7184.7 6110.9 6372.3 6478.1 6478.4 6480.4 4965.9 5006.8 5011.8 5012.5 5032.6 4871.4 4977.7 4999.7 5106.2 5173.3 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4412.75 Median:4969.31 stddev:1357.86 (27.3%) stddev-sans-first:1326.79 02:26:07 INFO - PROCESS | 1635 | Values: 338.8 355.2 363.7 375.9 377.4 4529.7 4746.6 5098.8 5158.6 5306.7 4206.7 4881.9 5080.4 5191.7 5229.9 3204.2 3477.0 3547.5 3790.4 3924.5 3271.6 3686.9 3982.9 3983.6 4029.9 3498.7 3964.7 3965.3 3966.8 4003.2 3514.6 3581.4 3986.2 4013.9 4022.9 3267.4 3304.7 3439.8 3463.3 3465.2 4513.8 5114.4 5126.0 5139.5 5144.9 4458.4 4537.3 4539.4 4572.3 4577.0 4941.8 5318.5 5484.8 5570.2 5581.9 3601.9 3803.2 3810.8 3816.3 3826.9 5561.7 5816.9 5837.7 5838.7 5850.7 3585.8 3732.0 3835.2 3846.2 3881.5 3273.3 3866.5 3914.9 3919.3 3938.0 3767.2 4553.0 4566.8 4569.0 4575.5 4914.3 5396.6 5632.5 5650.6 5668.2 1113.8 1263.4 1264.6 1268.0 1269.7 646.2 793.5 830.2 838.4 842.3 4331.5 4787.1 4959.0 4965.7 5116.3 5261.6 5525.9 5573.8 5593.4 5598.4 4703.7 4746.3 5067.3 5111.6 5297.9 2619.6 2841.0 2871.0 2883.8 2911.7 5277.7 5323.8 5335.3 5653.5 5739.1 4972.9 4975.4 5286.9 5631.6 5679.7 4710.3 5197.9 5329.2 5660.7 5705.9 4823.7 5011.4 5340.8 5504.9 5521.7 4598.7 4627.8 5086.3 5458.5 5544.3 4820.4 5652.9 5693.4 5732.7 5747.5 3426.9 3617.4 3925.3 3962.3 3975.4 5112.9 5329.0 5422.8 5474.4 5497.7 5381.4 5596.0 5608.8 5636.2 5639.6 4611.3 4696.9 5360.8 5607.9 5636.5 5286.6 5459.6 5512.4 5526.3 5551.8 5332.4 5338.3 5572.9 5579.0 5604.6 4759.3 5275.4 5379.9 5474.7 5510.1 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:20491.62 Median:4368.22 stddev:29056.81 (665.2%) stddev-sans-first:29100.38 02:26:07 INFO - PROCESS | 1635 | Values: 714.1 775.5 827.6 829.6 838.1 15517.7 16119.7 16158.0 16197.8 16198.8 14678.9 14840.0 14846.6 14850.6 14871.2 700.1 717.2 719.6 872.2 875.7 894.4 896.6 913.1 913.8 916.4 944.7 947.6 949.9 950.4 952.2 732.3 760.3 945.9 946.6 946.8 684.7 701.5 707.4 709.4 712.3 15014.8 15377.5 15404.2 15449.7 15453.7 12305.7 14106.9 14110.4 14114.9 14127.5 12445.2 12607.7 12615.3 12780.9 12965.5 4258.8 4378.6 4442.5 4595.7 4629.1 102380.0 103260.5 106032.2 108094.4 112109.4 10856.9 11050.7 11115.4 11220.0 11673.3 22782.9 22798.4 22803.8 22810.2 22820.0 7520.4 7627.1 7728.1 7743.0 7920.8 4134.2 4261.4 4335.2 4357.9 4417.2 3503.6 3609.8 3614.3 3615.9 3616.7 633.9 647.2 650.5 657.7 666.6 639.3 644.4 648.6 648.9 685.9 8537.4 9765.9 9836.6 9873.6 10094.8 574.4 616.8 651.9 666.9 690.9 4590.0 4876.1 4894.0 4896.7 4902.8 89782.0 103038.0 104490.0 107123.5 109815.0 86657.0 88018.0 88317.0 90681.0 90909.0 59278.0 62393.7 69603.0 79032.0 85430.1 9731.8 10662.2 11041.2 11416.6 11428.7 49775.0 50465.0 50885.2 51901.5 52766.0 64377.7 65458.7 66450.0 67214.7 68813.0 13119.3 13598.2 13858.7 14244.5 14260.6 14541.0 14589.8 15094.0 15345.3 15706.8 13510.8 13579.7 14082.9 14193.8 14270.9 13302.3 13927.9 14096.6 14107.4 14175.4 12815.2 13688.7 13713.9 13845.0 13878.2 9934.8 11257.3 11488.3 11516.9 11723.4 9720.0 9811.7 10277.6 10986.4 11008.9 02:26:07 INFO - PROCESS | 1635 | -------- Summary: end -------- 02:26:07 INFO - PROCESS | 1635 | 02:26:07 INFO - TEST-INFO | 1635: exit 0 02:26:07 INFO - TEST-OK | dromaeo_css | took 1118521ms 02:26:07 INFO - TEST-START | kraken 02:26:07 INFO - operating with platform_type : mac_ 02:26:07 INFO - Initialising browser for kraken test... 02:26:07 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpzfnAur/profile http://localhost:49242/getInfo.html) 02:26:10 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 02:26:10 INFO - PROCESS | 1645 | colorDepth:24 02:26:10 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 02:26:10 INFO - PROCESS | 1645 | __metrics 02:26:10 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:26:10 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:11 INFO - TEST-INFO | 1645: exit 0 02:26:11 INFO - Browser initialized. 02:26:11 INFO - Running cycle 1/1 for kraken test... 02:26:11 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpzfnAur/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:23 INFO - PROCESS | 1647 | RSS: Main: 213323776 02:26:23 INFO - PROCESS | 1647 | 02:26:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:27 INFO - PROCESS | 1647 | RSS: Main: 265715712 02:26:27 INFO - PROCESS | 1647 | 02:26:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 02:26:30 INFO - PROCESS | 1647 | RSS: Main: 274735104 02:26:30 INFO - PROCESS | 1647 | 02:26:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 02:26:34 INFO - PROCESS | 1647 | RSS: Main: 371875840 02:26:34 INFO - PROCESS | 1647 | 02:26:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 02:26:36 INFO - PROCESS | 1647 | RSS: Main: 276561920 02:26:36 INFO - PROCESS | 1647 | 02:26:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:39 INFO - PROCESS | 1647 | RSS: Main: 279547904 02:26:39 INFO - PROCESS | 1647 | 02:26:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:42 INFO - PROCESS | 1647 | RSS: Main: 318697472 02:26:42 INFO - PROCESS | 1647 | 02:26:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:46 INFO - PROCESS | 1647 | RSS: Main: 320045056 02:26:46 INFO - PROCESS | 1647 | 02:26:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 02:26:49 INFO - PROCESS | 1647 | RSS: Main: 315256832 02:26:49 INFO - PROCESS | 1647 | 02:26:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:52 INFO - PROCESS | 1647 | RSS: Main: 294916096 02:26:52 INFO - PROCESS | 1647 | 02:26:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:54 INFO - PROCESS | 1647 | RSS: Main: 297578496 02:26:54 INFO - PROCESS | 1647 | 02:26:56 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:57 INFO - PROCESS | 1647 | RSS: Main: 299421696 02:26:57 INFO - PROCESS | 1647 | 02:27:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:01 INFO - PROCESS | 1647 | RSS: Main: 317276160 02:27:01 INFO - PROCESS | 1647 | 02:27:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:04 INFO - PROCESS | 1647 | RSS: Main: 310247424 02:27:04 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 02:27:06 INFO - PROCESS | 1647 | RSS: Main: 354639872 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | __start_tp_report 02:27:06 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 02:27:06 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 02:27:06 INFO - PROCESS | 1647 | |i|pagename|runs| 02:27:06 INFO - PROCESS | 1647 | |0;ai-astar;115;116;118;115;114;116;114;114;115;115 02:27:06 INFO - PROCESS | 1647 | |1;audio-beat-detection;138;108;108;137;108;109;110;104;128;108 02:27:06 INFO - PROCESS | 1647 | |2;audio-dft;185;186;182;185;186;182;185;183;252;201 02:27:06 INFO - PROCESS | 1647 | |3;audio-fft;81;57;59;87;62;59;59;59;74;57 02:27:06 INFO - PROCESS | 1647 | |4;audio-oscillator;88;70;85;73;97;102;66;79;92;113 02:27:06 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;89;86;90;87;89;85;89;87;89;85 02:27:06 INFO - PROCESS | 1647 | |6;imaging-darkroom;98;98;96;98;98;98;96;97;97;97 02:27:06 INFO - PROCESS | 1647 | |7;imaging-desaturate;105;130;137;86;86;86;86;88;86;85 02:27:06 INFO - PROCESS | 1647 | |8;json-parse-financial;56;55;53;53;56;56;57;56;57;56 02:27:06 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;60;63;81;114;108;95;80;71;70;71 02:27:06 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;85;84;84;82;83;82;83;81;86;84 02:27:06 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;139;138;138;141;144;149;143;144;193;176 02:27:06 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;167;167;177;159;166;166;163;229;167;166 02:27:06 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;68;67;67;66;66;65;65;65;66;65 02:27:06 INFO - PROCESS | 1647 | __end_tp_report 02:27:06 INFO - PROCESS | 1647 | __start_cc_report 02:27:06 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1953 02:27:06 INFO - PROCESS | 1647 | __end_cc_report 02:27:06 INFO - PROCESS | 1647 | __startTimestamp1486117626783__endTimestamp 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | ------- Summary: start ------- 02:27:06 INFO - PROCESS | 1647 | Number of tests: 14 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:1.23 (1.1%) stddev-sans-first:1.30 02:27:06 INFO - PROCESS | 1647 | Values: 115.0 116.0 118.0 115.0 114.0 116.0 114.0 114.0 115.0 115.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:109.50 stddev:13.14 (12.0%) stddev-sans-first:11.21 02:27:06 INFO - PROCESS | 1647 | Values: 138.0 108.0 108.0 137.0 108.0 109.0 110.0 104.0 128.0 108.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:192.70 Median:185.50 stddev:21.54 (11.6%) stddev-sans-first:22.67 02:27:06 INFO - PROCESS | 1647 | Values: 185.0 186.0 182.0 185.0 186.0 182.0 185.0 183.0 252.0 201.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:11.06 (18.3%) stddev-sans-first:10.19 02:27:06 INFO - PROCESS | 1647 | Values: 81.0 57.0 59.0 87.0 62.0 59.0 59.0 59.0 74.0 57.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:82.00 stddev:14.98 (18.3%) stddev-sans-first:15.87 02:27:06 INFO - PROCESS | 1647 | Values: 88.0 70.0 85.0 73.0 97.0 102.0 66.0 79.0 92.0 113.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:89.00 stddev:1.84 (2.1%) stddev-sans-first:1.88 02:27:06 INFO - PROCESS | 1647 | Values: 89.0 86.0 90.0 87.0 89.0 85.0 89.0 87.0 89.0 85.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:98.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 02:27:06 INFO - PROCESS | 1647 | Values: 98.0 98.0 96.0 98.0 98.0 98.0 96.0 97.0 97.0 97.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:86.00 stddev:19.95 (23.2%) stddev-sans-first:20.97 02:27:06 INFO - PROCESS | 1647 | Values: 105.0 130.0 137.0 86.0 86.0 86.0 86.0 88.0 86.0 85.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 02:27:06 INFO - PROCESS | 1647 | Values: 56.0 55.0 53.0 53.0 56.0 56.0 57.0 56.0 57.0 56.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:71.00 stddev:18.56 (26.1%) stddev-sans-first:18.01 02:27:06 INFO - PROCESS | 1647 | Values: 60.0 63.0 81.0 114.0 108.0 95.0 80.0 71.0 70.0 71.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 02:27:06 INFO - PROCESS | 1647 | Values: 85.0 84.0 84.0 82.0 83.0 82.0 83.0 81.0 86.0 84.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:144.00 stddev:18.66 (13.0%) stddev-sans-first:19.32 02:27:06 INFO - PROCESS | 1647 | Values: 139.0 138.0 138.0 141.0 144.0 149.0 143.0 144.0 193.0 176.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:167.00 stddev:20.28 (12.1%) stddev-sans-first:21.41 02:27:06 INFO - PROCESS | 1647 | Values: 167.0 167.0 177.0 159.0 166.0 166.0 163.0 229.0 167.0 166.0 02:27:06 INFO - PROCESS | 1647 | 02:27:06 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 02:27:06 INFO - PROCESS | 1647 | Values: 68.0 67.0 67.0 66.0 66.0 65.0 65.0 65.0 66.0 65.0 02:27:06 INFO - PROCESS | 1647 | -------- Summary: end -------- 02:27:06 INFO - PROCESS | 1647 | 02:27:07 INFO - TEST-INFO | 1647: exit 0 02:27:07 INFO - TEST-OK | kraken | took 59773ms 02:27:07 INFO - SUITE-END | took 1178s 02:27:07 INFO - Completed test suite (00:19:38) 02:27:07 INFO - javascript benchmark 02:27:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.3373325334937, 3313.7183339416147, 3326.6839650233233, 3359.428897087495, 3376.5312089241183, 5644.04051311277, 5715.9428405715935, 5729.111987641912, 5741.569382296334, 5749.108888122342, 5701.6864072476, 5781.508571771394, 5783.681897495636, 5792.102224155252, 5819.825405237839, 5245.029669511134, 5269.156934890409, 5278.815241466549, 5282.894342113155, 5334.759935802879, 4139.275626765319, 4956.190990288536, 5176.12005958986, 5177.223416487519, 5356.812511562096, 5244.318238628973, 5271.024860400819, 5275.577953763709, 5277.076511610453, 5280.181571856349, 5294.10000299948, 5294.258803767476, 5295.28513650658, 5298.947010529884, 5302.0, 5147.0, 5250.65870718402, 5252.0, 5252.36971563411, 5287.4448182941005, 5823.010088285002, 5836.066229403275, 5837.795677151279, 5840.88318233633, 5847.795327163529, 6158.969205153946, 6190.288116866573, 6200.410960958701, 6202.596831205957, 6203.720832562545, 6287.434130928193, 6298.2756982947085, 6319.462845658125, 6326.43062124411, 6327.651979141146, 5122.615803814729, 5823.941760582382, 5825.970870145665, 5826.9708651456895, 5882.000059989812, 6187.84530386735, 6233.563650544418, 6246.6876656167005, 6287.2769631492965, 6296.937030629727, 6118.80192544137, 6159.798839226398, 6178.165947597106, 6228.283747369111, 6233.189685340877, 6295.6537390443045, 6320.241571011508, 6322.525810564226, 6325.430711235919, 6328.177336946167, 6135.601185922901, 6291.591046582049, 6302.243730752339, 6308.0537919311555, 6309.652969086745, 6138.296437970408, 6169.475594574512, 6221.160143380585, 6227.034809604518, 6233.252009758858, 5010.423801262901, 5010.974945125251, 5017.397912250481, 5028.296038554606, 5042.420121686053, 4464.933026004613, 4466.260854801564, 4472.9552704472535, 4493.213687604656, 4493.820247190141, 5626.1842032905, 5666.660000399989, 5677.460641239076, 5722.828315150552, 5735.598508104476, 6254.312025677172, 6293.96853015732, 6316.336784637639, 6319.557630965788, 6325.683715814191, 5774.162746401748, 5792.94207057924, 5799.710014499258, 5803.216565763568, 5846.590738648254, 5357.19642053695, 5357.812476563379, 5474.124140137559, 5482.5613950883835, 5502.147167189092, 6232.470240029467, 6252.468540173954, 6261.217347831612, 6291.622502649856, 6295.496360291074, 6192.504599631929, 6251.218597675291, 6254.530910181846, 6256.874862502634, 6313.05304204373, 6274.811755647338, 6276.8430789228805, 6288.496920246461, 6349.746010159542, 6362.854686156536, 6164.260288765377, 6258.780942666985, 6270.0, 6283.3716628338625, 6283.560150789401, 5168.8449346519665, 5539.279893613804, 6000.609960352563, 6147.938520614736, 6241.500679945502, 5947.434993675594, 6162.383761623802, 6174.228221472316, 6177.413145751147, 6207.472364849038, 6175.475084617858, 6189.907151392823, 6190.0, 6197.907031394623, 6208.130861679459, 5826.067829147316, 5845.3570107289015, 5936.732847021981, 5958.970205148947, 6047.637141771508, 6101.5188887447375, 6130.520435899211, 6157.630542167484, 6160.969195153995, 6169.2288463942, 5921.733521991435, 5928.911066334094, 6019.097135429721, 6024.096385542029, 6028.6985650716415], "value": 5719.711853468419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.76511744127936, 473.3846000199742, 492.5566989709261, 495.6431369414023, 499.23866104191103, 31588.68411315889, 37938.861834144984, 42272.78863605678, 42302.94242643932, 44101.11797764043, 43230.13539729203, 43633.34549981753, 43637.0, 43726.0, 43789.56210437902, 9202.309826762987, 9460.8580871287, 9469.147776700096, 9471.952640236788, 9490.240780737558, 8365.456245344034, 8572.571371431435, 9359.6724114656, 11380.0, 11410.657680269564, 11307.0, 11338.376389298584, 11398.658040258806, 11431.485583148778, 11436.828447573293, 8394.24451799341, 11295.887041129607, 11376.317420954769, 11424.42877856104, 11427.0, 8457.957710211409, 8612.18184272493, 8622.051574326819, 8633.568321583896, 11034.337939723642, 39277.0, 41416.0, 41473.1705365894, 41522.79238603818, 41589.0, 3063.8008529445515, 3488.790672559629, 3498.282852015356, 3518.2611651552947, 3650.0, 28757.0, 29369.412611747644, 29378.55932161019, 30295.0, 30604.387912241855, 3236.158598764315, 3299.6040475142895, 3361.966380336214, 3408.608010078823, 3408.829558522064, 484858.5757071192, 484942.0, 486953.0, 488702.0, 488826.55586722196, 61079.47301317414, 62968.0, 63259.6837015812, 63292.36707632865, 63534.0, 64185.0, 65883.0, 65892.34107658862, 65945.67027164834, 65994.67002664956, 16379.42672006498, 16966.0, 16999.0, 17059.061751603782, 17061.232244549024, 11817.172797904235, 12143.332116733487, 13127.540536081382, 13143.474261029452, 13216.140950838164, 13662.0, 14905.0, 15019.399224030916, 15054.924725376522, 15078.285908536349, 6993.545419547713, 7237.782866514013, 7239.0, 7292.744753933587, 7301.342879140902, 872.8385248729005, 885.5173930208052, 891.9554022298859, 899.7975455522455, 922.2760133295465, 29961.101166965025, 30149.0, 30178.080554559772, 30206.395872082874, 30425.935092272106, 1051.2536099369381, 1067.7063807453012, 1079.3901445683164, 1088.678839742278, 1111.927724697892, 15446.382144714085, 15459.690806184039, 15497.302621382065, 15615.765763513557, 15936.601584960237, 550624.0, 554208.0, 555132.0, 556870.0, 557690.4230957639, 59609.40390596038, 59731.0, 59782.0, 59827.70086149542, 59850.0, 1440.5750303660445, 1455.6069861137435, 1467.8091848059685, 1472.2123663839795, 1477.6084337650746, 27479.86260068687, 29432.11703648894, 29605.407891842475, 30255.579553635216, 30272.84863575668, 50131.49868501268, 50397.74801125971, 50625.0, 50635.493645064555, 50718.492815071375, 543429.282853599, 548757.0, 548883.0, 549554.0, 549728.0, 39056.0, 40037.59962400455, 40140.197196055335, 40476.190476189724, 40542.79728601338, 43755.56244437515, 46638.53361466342, 46648.06703865971, 46883.0, 47001.29498057463, 37319.06702332355, 37834.81082594569, 38361.040973975876, 38768.61231387763, 39464.80267598759, 37958.810205948794, 38194.0, 38698.22603547857, 38933.8053309743, 39174.216515670094, 35109.47335789914, 36365.72719954789, 37449.6255037457, 38280.42579361368, 38293.61706383012, 31744.841275793475, 33403.498947516295, 33406.49890251697, 33470.0, 33495.33009339751, 23754.0, 24048.038078477366, 24525.773711314007, 24918.626220606344, 25346.873265633552], "value": 20101.968000483037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.49849959306766, 362.5866512176118, 390.90227443139213, 402.5290410220043, 426.8079364286072, 15254.618634534128, 15465.994710343834, 18843.62312753746, 20920.37238882832, 21623.891880540614, 20309.796902030976, 20498.176734838034, 20823.895880520613, 22068.668969965463, 22617.434564135903, 5846.801405711819, 5877.823665290048, 5987.042073268278, 6019.909701354483, 6027.72875220614, 6005.00917348637, 6028.909566356509, 6076.210092687967, 6078.574499784994, 6085.056816193497, 4191.790410479479, 4425.77871106445, 4449.021215332622, 6658.400743933069, 6757.763478278262, 6488.0, 6714.865702685944, 6721.260661327299, 6732.057511948331, 6755.121834161552, 5805.36141024487, 5866.823995280149, 5877.030290002144, 5893.852653683649, 5907.527397808208, 27149.864250678816, 27179.184624461297, 27482.0, 27552.724472755417, 27623.171304860887, 2802.621646077794, 2821.901233456819, 2834.5039618066758, 2848.757855582278, 2859.042220856016, 15510.767338489932, 16007.359705611761, 16082.839171608251, 16249.431269905497, 16528.0, 1756.5081777102432, 1847.2132129135218, 1853.9907300463547, 1855.554666879939, 1871.6163186546726, 101804.0, 112543.43728281389, 137990.0, 143511.28244358712, 143581.0, 11149.275297105662, 11917.106217033757, 12036.759264814655, 12123.636290911287, 12136.696582585506, 16017.359305627877, 16030.919845400931, 16052.0, 16069.919650401907, 16120.516384508484, 8579.82840343202, 9015.323850711224, 9025.104728007193, 9116.680916167903, 9133.77165570866, 8877.0, 8883.73348799537, 8890.822183556293, 9030.45817250967, 9053.230475409533, 4866.515712707587, 4872.1473742094995, 4878.926816097762, 4879.316895634614, 4947.48051454592, 1664.3093116356577, 1715.9618430849407, 1996.5807180491968, 2025.6225766478642, 2026.7466566679166, 988.2785566536469, 1002.9097381235724, 1008.178334657252, 1017.9083882450615, 1026.2149455666422, 20811.271605493734, 21168.941552922293, 21197.25809596657, 21318.680219796715, 21399.45517090518, 784.2980532423448, 993.8707967964118, 1023.902729240721, 1030.7114008077751, 1041.8645576075214, 10130.936251693465, 10773.784524309627, 10959.06847917936, 11030.117590592734, 11043.558257669763, 724143.0, 733126.0, 738708.0, 741701.0, 752281.0, 137280.0, 138308.0, 143058.0, 145268.0, 147642.26178869038, 889.4574309671095, 961.3847137831793, 978.5938835383379, 1017.8422344536609, 1020.9489525523694, 18464.261429543207, 19437.8056219436, 20208.79791202069, 20556.0, 20626.071826767533, 57806.0, 58527.12209316949, 59681.701591493504, 60481.48796280128, 61504.69247653733, 62240.688796555725, 76608.23391766011, 80435.0, 81973.0, 90031.8488852887, 8356.791080223044, 8370.58147092655, 8373.07896131413, 8748.950125984922, 8964.91035089667, 12070.637880863587, 12828.29444380568, 13556.05107642495, 13738.65653358674, 13976.860231397555, 11129.054030407506, 11397.373144476802, 11505.827412588651, 11898.702532436759, 11957.461914213707, 11047.447627618747, 11497.94251028773, 11532.502324093442, 11798.0, 11955.880441195477, 6167.876642467215, 9644.9035509644, 9682.644429779977, 10112.797744045225, 11387.487563059516, 8411.83176336482, 8514.0, 8640.697575584825, 8641.82716345657, 9008.684696035607, 9571.425714457155, 11153.107751379708, 11400.087992960378, 11898.22661526998, 11996.58011969577], "value": 10092.676673181097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.8395200599925, 1430.9212993285364, 1432.4341884955443, 1452.912825230487, 1454.1057249791381, 7973.521588704674, 8382.622781974811, 8389.87415188771, 8390.91609083909, 8400.621972011259, 7312.305330993547, 7607.125180604232, 7613.162552119263, 7920.445568810185, 8172.305354044914, 2241.6413373860146, 2296.01271453275, 2301.2175860207526, 2303.8272129590264, 2304.608216603173, 1995.6108558831033, 2308.088305119477, 2343.9062437502566, 2354.764523547649, 2357.1514254868234, 2043.632146213681, 2112.7887211278826, 2235.441139715071, 2285.1887579909144, 2318.4899322149186, 2294.8508346957396, 2297.781710737469, 2300.229423143249, 2305.7578954209903, 2308.3882771065682, 2051.476873397289, 2150.354893531934, 2289.8168146548237, 2329.5108027314286, 2329.5457385809773, 8290.29532489733, 8357.874631880526, 8370.0, 8389.706360277421, 8418.0, 5015.072211640858, 5178.575891629832, 5182.0, 5185.040767457995, 5207.244949482341, 3279.212988882651, 3406.863725450979, 3516.085817687394, 3517.2262102337445, 3522.348365552381, 1144.2733863996339, 1212.9150959432843, 1248.5442813373054, 1309.3453273363318, 1760.119940029985, 10734.409607471585, 10737.355758654428, 10838.837417438823, 10852.837207441895, 10861.83707244392, 4324.35134729793, 4457.353683715843, 4518.186726389215, 4529.796159172845, 4539.886502837389, 8638.17937295956, 8665.35009874262, 8677.739667809976, 8679.739607811649, 8681.2186903179, 5111.616628752859, 5114.64197506171, 5121.641485096082, 5123.205903085028, 5133.974330128325, 4263.445752052214, 4434.002349471343, 4507.977460112678, 4757.429108507002, 4768.380110585602, 3685.3366394048794, 3709.573399059143, 3773.735838491279, 3818.904527386782, 3825.9617403826164, 1148.4774427635407, 1153.9365334906493, 1162.6395817296666, 1172.5427083437467, 1173.5129921082826, 780.9140994490601, 916.6654171227455, 918.2195134135931, 931.189864817613, 950.3015283766426, 5424.484673955968, 5743.483086522233, 5757.884842303214, 5764.308283005982, 5811.3316968548315, 957.2963871554402, 969.6654654144309, 970.5195928015678, 1011.9392836429838, 1029.9330543514648, 3648.3980143276062, 3792.469054332396, 3823.8719577724637, 3922.9019274517796, 3965.72239943207, 9586.424814511152, 9955.153811925922, 10078.445685487368, 10113.190944724405, 10143.64497242593, 9894.109530142321, 9951.203903687687, 9986.500674966223, 10067.0, 10083.991600839858, 7713.961430192925, 7822.765317040498, 7842.960785196037, 7938.04743430792, 7990.840183196304, 4879.487653796442, 4940.851774446773, 5364.463553644604, 5448.45515448452, 5482.23248745168, 8999.415038022507, 9140.405873618194, 9171.495567743837, 9277.350585458953, 9399.154076133182, 9265.166135047879, 9318.767030824283, 9347.252219822261, 9410.153086222273, 9501.667441639509, 6287.088372186099, 6505.121808555785, 6508.284088750328, 6727.0, 6836.965815170893, 7741.45809793309, 7965.044194696674, 7978.760637180661, 8010.078840933134, 8024.598770061591, 6936.687849046906, 7057.36483716468, 7174.1032370953635, 7239.321451063141, 7313.378362839218, 6454.709538070704, 6897.482688798461, 7031.296870312928, 7143.285671432815, 7184.748533801292, 6110.877782444415, 6372.330905255067, 6478.060681201294, 6478.384553467413, 6480.416762491398, 4965.900681986413, 5006.824761133488, 5011.799528018839, 5012.47369026247, 5032.572231360376, 4871.415430148405, 4977.701337919591, 4999.725015124203, 5106.183010718267, 5173.32746742921], "value": 4384.440513783518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.77132935268696, 355.2149749054589, 363.69086276664837, 375.8590528551793, 377.4489245701276, 4529.728216307016, 4746.62027037837, 5098.847034588964, 5158.6131040171995, 5306.734663266836, 4206.747595144286, 4881.900782663453, 5080.415752188499, 5191.740412979346, 5229.940484816378, 3204.221656980375, 3476.974292583694, 3547.467879818022, 3790.4459171739522, 3924.54867690215, 3271.6401195868552, 3686.8525258989607, 3982.860599879005, 3983.6016398360075, 4029.858954936578, 3498.667626575484, 3964.709291288224, 3965.325894597925, 3966.8214930328204, 4003.15933653933, 3514.6485351464776, 3581.3553560359255, 3986.222686576119, 4013.8795836124964, 4022.879313620596, 3267.3628642414737, 3304.653011433789, 3439.7592168548213, 3463.2727127303046, 3465.203003309253, 4513.819447222108, 5114.411842638107, 5126.000859664734, 5139.486051394831, 5144.922826157611, 4458.4426946631675, 4537.251353526664, 4539.364488971547, 4572.262540234689, 4576.954230457686, 4941.827036053721, 5318.468153184689, 5484.8354549363585, 5570.2480165177585, 5581.939431508001, 3601.8559257629663, 3803.2124901296347, 3810.79040652764, 3816.263600061965, 3826.8660596879254, 5561.694106824123, 5816.8836623267725, 5837.67892765902, 5838.678872662002, 5850.678212698257, 3585.8386372613295, 3731.981340093282, 3835.1562656215588, 3846.1730727893637, 3881.5342158941107, 3273.2798784267425, 3866.4586957825927, 3914.8825535233987, 3919.2553414851086, 3937.9803100984313, 3767.1523907120677, 4553.042191857467, 4566.840160594364, 4568.954310456853, 4575.542445755398, 4914.336564563738, 5396.595255355864, 5632.52123569493, 5650.604457688005, 5668.234788303609, 1113.8162203236536, 1263.412513181375, 1264.5953294945714, 1268.0, 1269.695273134441, 646.1954866191528, 793.5238856686058, 830.1988581019225, 838.4256784102909, 842.3093063687717, 4331.501877284152, 4787.0904528139545, 4958.9832235888325, 4965.702057876539, 5116.286044175168, 5261.579073674174, 5525.889482210333, 5573.777048918079, 5593.440655934455, 5598.440155984369, 4703.717776933395, 4746.311784791186, 5067.3412456381175, 5111.642185047011, 5297.947020529746, 2619.64634774303, 2841.0414508542767, 2871.0, 2883.812552184101, 2911.7233862783, 5277.656952298088, 5323.813666521653, 5335.306410166653, 5653.519450846642, 5739.13912913058, 4972.916791589238, 4975.4278258000795, 5286.8942621148135, 5631.633943793722, 5679.716014199356, 4710.3405523226775, 5197.870053248624, 5329.173978033411, 5660.660360378391, 5705.94440028596, 4823.734694591831, 5011.423686275979, 5340.759665815125, 5504.9174262385295, 5521.668699878021, 4598.724076555417, 4627.768611569475, 5086.262491938722, 5458.4541545845095, 5544.279243698294, 4820.4456487504385, 5652.943470565242, 5693.402192769865, 5732.713364331683, 5747.511461525817, 3426.8629254830525, 3617.385044542487, 3925.3326934420647, 3962.3264045111823, 3975.4159796132744, 5112.948870511247, 5328.973355133355, 5422.827645827235, 5474.370447398441, 5497.697626630414, 5381.434949330264, 5595.972020139873, 5608.831735047955, 5636.2245892543715, 5639.6334238274385, 4611.308303754464, 4696.906061878812, 5360.839174824761, 5607.859803504945, 5636.464535869086, 5286.603504737083, 5459.645123066988, 5512.448755124456, 5526.309211348582, 5551.750171242223, 5332.440093790251, 5338.304156400993, 5572.916406253828, 5579.0, 5604.635698679573, 4759.333693282874, 5275.419703832652, 5379.892402151857, 5474.671519708831, 5510.0632892409185], "value": 3988.952223340096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.0752725220842, 775.4881778026501, 827.571078883477, 829.5852073963018, 838.1157878438249, 15517.689646207084, 16119.677606447864, 16158.0, 16197.83802161978, 16198.838011619895, 14678.85321146791, 14840.0, 14846.55460336189, 14850.554483365517, 14871.182084985321, 700.0549258501034, 717.2468907646976, 719.6293908637056, 872.2237208884098, 875.6541166239332, 894.4454438248296, 896.551724137931, 913.127962795532, 913.8446464101086, 916.4180745226762, 944.6929747831948, 947.554649314821, 949.852772820214, 950.4487397309579, 952.1716106986931, 732.2969948849058, 760.2967255288836, 945.8533927241255, 946.5551190940247, 946.8153710026513, 684.6816230452863, 701.5439964023375, 707.3527722134241, 709.3722055980443, 712.3268511256813, 15014.774778378332, 15377.538673839803, 15404.229788510529, 15449.691006179813, 15453.690926181413, 12305.692357691129, 14106.858931410658, 14110.365033573515, 14114.92942535291, 14127.505537306248, 12445.191062580903, 12607.684807879785, 12615.306158161298, 12780.872191278062, 12965.546205882749, 4258.787060646986, 4378.562143785628, 4442.489113751928, 4595.655325850541, 4629.097326021427, 102380.0, 103260.48369758103, 106032.22854971545, 108094.37858432208, 112109.43945280302, 10856.891431085745, 11050.668479945614, 11115.44422778874, 11220.046296064926, 11673.299602023906, 22782.886085569466, 22798.430039249153, 22803.771962280498, 22810.20164294242, 22820.0, 7520.435967302475, 7627.0847498299445, 7728.072631284282, 7743.0, 7920.841583168304, 4134.235166494208, 4261.403403523447, 4335.176316499855, 4357.869263922087, 4417.160739459492, 3503.649635036476, 3609.7653652512504, 3614.2590768892314, 3615.94576081359, 3616.72874534411, 633.9429451349308, 647.1942431672597, 650.5056157320375, 657.7204688007578, 666.5600703535644, 639.335091504839, 644.4328990488434, 648.5654611410366, 648.8994205898093, 685.8971154326791, 8537.402381833212, 9765.853512197322, 9836.606535738634, 9873.555689993967, 10094.798104037878, 574.3739324136711, 616.7748771698388, 651.9419969180921, 666.8632930249287, 690.9032735417046, 4590.0, 4876.146674331978, 4894.0, 4896.681715688469, 4902.754862256944, 89782.0, 103038.0, 104489.95510044802, 107123.46438267759, 109815.0, 86657.0, 88018.0, 88317.0, 90681.0, 90909.0, 59278.0, 62393.68803155955, 69602.9559556597, 79032.0, 85430.14569854346, 9731.805363892825, 10662.200334974752, 11041.227114101936, 11416.600418985296, 11428.657140285804, 49775.0, 50465.0, 50885.236721449946, 51901.480985189664, 52766.0, 64377.678111611014, 65458.672706636164, 66450.0, 67214.66392668005, 68813.0, 13119.27843968591, 13598.184108953494, 13858.722825543231, 14244.473484152055, 14260.572182834532, 14541.0, 14589.781153282496, 15094.0, 15345.309461074501, 15706.842931570538, 13510.797338040134, 13579.728405432033, 14082.929585352418, 14193.787093193818, 14270.857291426953, 13302.334883255991, 13927.930360348133, 14096.577102686935, 14107.435702571782, 14175.432982680577, 12815.16701414405, 13688.726225475633, 13713.931430342784, 13845.030847840555, 13878.23669698136, 9934.751631209278, 11257.324560526395, 11488.253263537843, 11516.94241528787, 11723.35029145219, 9719.951400242953, 9811.656592019244, 10277.588896444058, 10986.395748233925, 11008.944955275172], "value": 7626.366457987101, "unit": "score"}], "name": "dromaeo_css", "value": 7327.569250481142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 118.0, 115.0, 114.0, 116.0, 114.0, 114.0, 115.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 108.0, 137.0, 108.0, 109.0, 110.0, 104.0, 128.0, 108.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 185.0, 186.0, 182.0, 185.0, 183.0, 252.0, 201.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 59.0, 87.0, 62.0, 59.0, 59.0, 59.0, 74.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 73.0, 97.0, 102.0, 66.0, 79.0, 92.0, 113.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 89.0, 85.0, 89.0, 87.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 96.0, 98.0, 98.0, 98.0, 96.0, 97.0, 97.0, 97.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 130.0, 137.0, 86.0, 86.0, 86.0, 86.0, 88.0, 86.0, 85.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 53.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 81.0, 114.0, 108.0, 95.0, 80.0, 71.0, 70.0, 71.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 82.0, 83.0, 82.0, 83.0, 81.0, 86.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 138.0, 141.0, 144.0, 149.0, 143.0, 144.0, 193.0, 176.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 177.0, 159.0, 166.0, 166.0, 163.0, 229.0, 167.0, 166.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1467.4, "alertThreshold": 2.0}]} 02:27:08 INFO - Return code: 0 02:27:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:27:08 ERROR - # TBPL SUCCESS # 02:27:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:08 INFO - 2017-02-03 02:27:08.104 screenresolution[1651:9922] starting screenresolution argv=screenresolution get 02:27:08 INFO - 2017-02-03 02:27:08.107 screenresolution[1651:9922] Display 0: 1600x1200x32@60 02:27:08 INFO - 2017-02-03 02:27:08.113 screenresolution[1652:9925] starting screenresolution argv=screenresolution list 02:27:08 INFO - Available Modes on Display 0 02:27:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:08 INFO - Intel Iris: 02:27:08 INFO - Chipset Model: Intel Iris 02:27:08 INFO - Type: GPU 02:27:08 INFO - Bus: Built-In 02:27:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:08 INFO - Vendor: Intel (0x8086) 02:27:08 INFO - Device ID: 0x0a2e 02:27:08 INFO - Revision ID: 0x0009 02:27:08 INFO - Displays: 02:27:08 INFO - Display: 02:27:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:08 INFO - Display Serial Number: 1600x1200 60 02:27:08 INFO - Main Display: Yes 02:27:08 INFO - Mirror: Off 02:27:08 INFO - Online: Yes 02:27:08 INFO - Rotation: Supported 02:27:08 INFO - Return code: 0 02:27:08 INFO - Running post-action listener: _resource_record_post_action 02:27:08 INFO - [mozharness: 2017-02-03 10:27:08.349150Z] Finished run-tests step (success) 02:27:08 INFO - Running post-run listener: _resource_record_post_run 02:27:08 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38867968; Write bytes: 507840000; Read time: 386; Write time: 1693 02:27:08 INFO - TinderboxPrint: CPU usage
53.7% 02:27:08 INFO - TinderboxPrint: I/O read bytes / time
38,867,968 / 386 02:27:08 INFO - TinderboxPrint: I/O write bytes / time
507,840,000 / 1,693 02:27:08 INFO - TinderboxPrint: CPU idle
2,219.3 (46.3%) 02:27:08 INFO - TinderboxPrint: CPU system
966.0 (20.1%) 02:27:08 INFO - TinderboxPrint: CPU user
1,612.3 (33.6%) 02:27:08 INFO - TinderboxPrint: Swap in / out
246,427,648 / 0 02:27:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205287936; Write bytes: 200496640; Read time: 15548; Write time: 467 02:27:08 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36799488; Write bytes: 296386560; Read time: 356; Write time: 1155 02:27:08 INFO - Running post-run listener: _upload_blobber_files 02:27:08 INFO - Blob upload gear active. 02:27:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:08 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 02:27:08 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'] 02:27:08 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 02:27:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:09 INFO - (blobuploader) - INFO - Done attempting. 02:27:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:11 INFO - (blobuploader) - INFO - Done attempting. 02:27:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:27:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:12 INFO - (blobuploader) - INFO - Done attempting. 02:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:14 INFO - (blobuploader) - INFO - Done attempting. 02:27:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:14 INFO - Return code: 0 02:27:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65e9cf390b9ec57a74ab17508bbdb3418b531a1f67ab7baae5f83c688c29490dba471782bb01e5d64ffe6712a26cac2f5881fc4030969905cfcc2a321de0d020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd33aaa5f3f4a2f281632bd3bf863f3c9207d1d9530b77236e2f9cd0f901d580aca7852adddeba319ed4b3d8139b003e16d66c2e02f9133ab7fc62f7e1563e15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86d2e30d05a9a86af73b06f608195263462db8d8ad0958a56d6dba019f719977c84b79021416d0bc7696a2d82a86a0109cf9bcbcbdb2b1b97f4080a832cd484", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40ce1b8ba5f036b1443db0afac22fabebe82dd0390604a720d1699f77c361ca2ca1875a56c856b8eccc7fa6a3f898cf61795121301b72341c8794a604aa29a8"} 02:27:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:14 INFO - Contents: 02:27:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65e9cf390b9ec57a74ab17508bbdb3418b531a1f67ab7baae5f83c688c29490dba471782bb01e5d64ffe6712a26cac2f5881fc4030969905cfcc2a321de0d020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd33aaa5f3f4a2f281632bd3bf863f3c9207d1d9530b77236e2f9cd0f901d580aca7852adddeba319ed4b3d8139b003e16d66c2e02f9133ab7fc62f7e1563e15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86d2e30d05a9a86af73b06f608195263462db8d8ad0958a56d6dba019f719977c84b79021416d0bc7696a2d82a86a0109cf9bcbcbdb2b1b97f4080a832cd484", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40ce1b8ba5f036b1443db0afac22fabebe82dd0390604a720d1699f77c361ca2ca1875a56c856b8eccc7fa6a3f898cf61795121301b72341c8794a604aa29a8"} 02:27:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:14 INFO - Copying logs to upload dir... 02:27:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.245440 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-03 02:27:14.215477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 02:27:14.218780) ========= 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.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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/65e9cf390b9ec57a74ab17508bbdb3418b531a1f67ab7baae5f83c688c29490dba471782bb01e5d64ffe6712a26cac2f5881fc4030969905cfcc2a321de0d020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd33aaa5f3f4a2f281632bd3bf863f3c9207d1d9530b77236e2f9cd0f901d580aca7852adddeba319ed4b3d8139b003e16d66c2e02f9133ab7fc62f7e1563e15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86d2e30d05a9a86af73b06f608195263462db8d8ad0958a56d6dba019f719977c84b79021416d0bc7696a2d82a86a0109cf9bcbcbdb2b1b97f4080a832cd484", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40ce1b8ba5f036b1443db0afac22fabebe82dd0390604a720d1699f77c361ca2ca1875a56c856b8eccc7fa6a3f898cf61795121301b72341c8794a604aa29a8"} build_url:https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/c8esUp2cS1Okx5DIkzXXDA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65e9cf390b9ec57a74ab17508bbdb3418b531a1f67ab7baae5f83c688c29490dba471782bb01e5d64ffe6712a26cac2f5881fc4030969905cfcc2a321de0d020", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd33aaa5f3f4a2f281632bd3bf863f3c9207d1d9530b77236e2f9cd0f901d580aca7852adddeba319ed4b3d8139b003e16d66c2e02f9133ab7fc62f7e1563e15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86d2e30d05a9a86af73b06f608195263462db8d8ad0958a56d6dba019f719977c84b79021416d0bc7696a2d82a86a0109cf9bcbcbdb2b1b97f4080a832cd484", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40ce1b8ba5f036b1443db0afac22fabebe82dd0390604a720d1699f77c361ca2ca1875a56c856b8eccc7fa6a3f898cf61795121301b72341c8794a604aa29a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 02:27:14.253369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:27:14.253742) ========= 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.WolNqTgU9D/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.TkPcbIDcEY/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 02:27:14.303176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 02:27:14.303504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 02:27:14.303928) ========= ========= Total master_lag: 0.18 =========