builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1493728290.54 results: success (0) buildid: 20170502030211 builduid: 5b4c31aedf1c48e09309ae87d394a862 revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.543568) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.544050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.544331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.567759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.568083) ========= 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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-05-02 05:31:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.4M=0.001s 2017-05-02 05:31:30 (12.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126176 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.720376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.720704) ========= 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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.021640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:30.769872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 05:31:30.770236) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-05-02 05:31:30,852 truncating revision to first 12 chars 2017-05-02 05:31:30,852 Setting DEBUG logging. 2017-05-02 05:31:30,852 attempt 1/10 2017-05-02 05:31:30,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48c0fd9c9ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 05:31:31,713 unpacking tar archive at: mozilla-central-48c0fd9c9ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.122482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-02 05:31:31.916890) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:31.917230) ========= script_repo_revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:31.917639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:31.917925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 05:31:31.938139) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-02 05:31:31.938491) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:31:32 INFO - MultiFileLogger online at 20170502 05:31:32 in /builds/slave/test 05:31:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:32 INFO - {'append_to_log': False, 05:31:32 INFO - 'base_work_dir': '/builds/slave/test', 05:31:32 INFO - 'blob_upload_branch': 'Firefox', 05:31:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:32 INFO - 'branch': 'Firefox', 05:31:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:32 INFO - 'config_files': ('talos/mac_config.py',), 05:31:32 INFO - 'default_actions': ('clobber', 05:31:32 INFO - 'read-buildbot-config', 05:31:32 INFO - 'download-and-extract', 05:31:32 INFO - 'populate-webroot', 05:31:32 INFO - 'create-virtualenv', 05:31:32 INFO - 'install', 05:31:32 INFO - 'run-tests'), 05:31:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:32 INFO - 'download_minidump_stackwalk': True, 05:31:32 INFO - 'download_symbols': 'ondemand', 05:31:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:32 INFO - 'gecko_profile': False, 05:31:32 INFO - 'gecko_profile_interval': 0, 05:31:32 INFO - 'installer_path': 'installer.exe', 05:31:32 INFO - 'log_level': 'info', 05:31:32 INFO - 'log_name': 'talos', 05:31:32 INFO - 'log_to_console': True, 05:31:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:32 INFO - 'opt_config_files': (), 05:31:32 INFO - 'pip_index': False, 05:31:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:32 INFO - 'cmd': ('bash', 05:31:32 INFO - '-c', 05:31:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:32 INFO - 'enabled': True, 05:31:32 INFO - 'halt_on_failure': False, 05:31:32 INFO - 'name': 'check_screen_resolution'},), 05:31:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:32 INFO - 'cmd': ('bash', 05:31:32 INFO - '-c', 05:31:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:32 INFO - 'enabled': True, 05:31:32 INFO - 'halt_on_failure': False, 05:31:32 INFO - 'name': 'check_screen_resolution'},), 05:31:32 INFO - 'run_cmd_checks_enabled': True, 05:31:32 INFO - 'suite': 'dromaeojs', 05:31:32 INFO - 'system_bits': '32', 05:31:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:32 INFO - 'title': 't-yosemite-r7-0258', 05:31:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:32 INFO - 'use_talos_json': True, 05:31:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:32 INFO - 'work_dir': 'build'} 05:31:32 INFO - [mozharness: 2017-05-02 12:31:32.143459Z] Running clobber step. 05:31:32 INFO - Running pre-action listener: _resource_record_pre_action 05:31:32 INFO - Running main action method: clobber 05:31:32 INFO - rmtree: /builds/slave/test/build 05:31:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:35 INFO - Running post-action listener: _resource_record_post_action 05:31:35 INFO - [mozharness: 2017-05-02 12:31:35.364545Z] Finished clobber step (success) 05:31:35 INFO - [mozharness: 2017-05-02 12:31:35.364676Z] Running read-buildbot-config step. 05:31:35 INFO - Running pre-action listener: _resource_record_pre_action 05:31:35 INFO - Running main action method: read_buildbot_config 05:31:35 INFO - Using buildbot properties: 05:31:35 INFO - { 05:31:35 INFO - "project": "", 05:31:35 INFO - "product": "firefox", 05:31:35 INFO - "script_repo_revision": "production", 05:31:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:31:35 INFO - "repository": "", 05:31:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:31:35 INFO - "buildid": "20170502030211", 05:31:35 INFO - "stage_platform": "macosx64", 05:31:35 INFO - "basedir": "/builds/slave/test", 05:31:35 INFO - "nightly_build": "True", 05:31:35 INFO - "buildnumber": 31, 05:31:35 INFO - "slavename": "t-yosemite-r7-0258", 05:31:35 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:31:35 INFO - "platform": "yosemite_r7", 05:31:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:35 INFO - "branch": "mozilla-central", 05:31:35 INFO - "repo_path": "mozilla-central", 05:31:35 INFO - "revision": "48c0fd9c9ec5d68061ea7b59358874ae8da72572", 05:31:35 INFO - "pgo_build": "False", 05:31:35 INFO - "builduid": "5b4c31aedf1c48e09309ae87d394a862", 05:31:35 INFO - "slavebuilddir": "test" 05:31:35 INFO - } 05:31:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:31:35 INFO - Running post-action listener: _resource_record_post_action 05:31:35 INFO - [mozharness: 2017-05-02 12:31:35.368027Z] Finished read-buildbot-config step (success) 05:31:35 INFO - [mozharness: 2017-05-02 12:31:35.368117Z] Running download-and-extract step. 05:31:35 INFO - Running pre-action listener: _resource_record_pre_action 05:31:35 INFO - Running main action method: download_and_extract 05:31:35 INFO - mkdir: /builds/slave/test/build/tests 05:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:35 INFO - trying https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:35 INFO - Downloading https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:31:36 INFO - Downloaded 1325 bytes. 05:31:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:31:36 INFO - Using the following test package requirements: 05:31:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:31:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:31:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:31:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'jsshell-mac.zip'], 05:31:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:31:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:31:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:31:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:31:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:31:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:31:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:31:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:36 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:31:38 INFO - Content-Length response header: 52700225 05:31:38 INFO - Bytes received: 52700225 05:31:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:31:55 INFO - Content-Length response header: 52700225 05:31:55 INFO - Bytes received: 52700225 05:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:32:12 INFO - Content-Length response header: 14408811 05:32:12 INFO - Bytes received: 14408811 05:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:12 INFO - trying https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:12 INFO - Downloading https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:32:14 INFO - Downloaded 71320366 bytes. 05:32:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:14 INFO - mkdir: /builds/slave/test/properties 05:32:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:14 INFO - Contents: 05:32:14 INFO - build_url:https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:32:15 INFO - Running post-action listener: _resource_record_post_action 05:32:15 INFO - Running post-action listener: set_extra_try_arguments 05:32:15 INFO - [mozharness: 2017-05-02 12:32:15.458929Z] Finished download-and-extract step (success) 05:32:15 INFO - [mozharness: 2017-05-02 12:32:15.459074Z] Running populate-webroot step. 05:32:15 INFO - Running pre-action listener: _resource_record_pre_action 05:32:15 INFO - Running main action method: populate_webroot 05:32:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:15 INFO - '--tppagecycles', 05:32:15 INFO - '7'], 05:32:15 INFO - 'tests': ['tsvgm']}}, 05:32:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['damp', 'tps']}, 05:32:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'tests': ['damp', 'tps']}, 05:32:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['dromaeo_dom']}, 05:32:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:32:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:32:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:32:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:32:15 INFO - 'bloom_basic_ref']}, 05:32:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tsvgx', 05:32:15 INFO - 'tsvgr_opacity', 05:32:15 INFO - 'tart', 05:32:15 INFO - 'tscrollx', 05:32:15 INFO - 'cart', 05:32:15 INFO - 'tsvg_static']}, 05:32:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:15 INFO - 'tsvgr_opacity', 05:32:15 INFO - 'tart', 05:32:15 INFO - 'tscrollx', 05:32:15 INFO - 'cart', 05:32:15 INFO - 'tsvg_static']}, 05:32:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tp5o']}, 05:32:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:32:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s', 05:32:15 INFO - '--xperf_path', 05:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:15 INFO - 'tests': ['tp5n']}, 05:32:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:32:15 INFO - 'talos_options': ['--xperf_path', 05:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:15 INFO - 'tests': ['tp5n']}}, 05:32:15 INFO - 'talos.zip': {'path': '', 05:32:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:15 INFO - Running post-action listener: _resource_record_post_action 05:32:15 INFO - [mozharness: 2017-05-02 12:32:15.478153Z] Finished populate-webroot step (success) 05:32:15 INFO - [mozharness: 2017-05-02 12:32:15.478288Z] Running create-virtualenv step. 05:32:15 INFO - Running pre-action listener: _resource_record_pre_action 05:32:15 INFO - Running main action method: create_virtualenv 05:32:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:15 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 05:32:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:15 INFO - Using real prefix '/tools/python27' 05:32:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:19 INFO - Installing pip.................done. 05:32:19 INFO - Return code: 0 05:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:19 INFO - Reading from file tmpfile_stdout 05:32:19 INFO - Output received: 05:32:19 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) 05:32:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:19 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 05:32:19 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 05:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:19 INFO - 'HOME': '/Users/cltbld', 05:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PAGER': '/bin/cat', 05:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test', 05:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:19 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - 'XPC_FLAGS': '0x0', 05:32:19 INFO - 'XPC_SERVICE_NAME': '0', 05:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 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 05:32:19 INFO - Cleaning up... 05:32:19 INFO - Return code: 0 05:32:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:19 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 05:32:19 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 05:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:19 INFO - 'HOME': '/Users/cltbld', 05:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PAGER': '/bin/cat', 05:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test', 05:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:19 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - 'XPC_FLAGS': '0x0', 05:32:19 INFO - 'XPC_SERVICE_NAME': '0', 05:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 INFO - Downloading/unpacking psutil>=3.1.1 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:23 INFO - Installing collected packages: psutil 05:32:23 INFO - Running setup.py install for psutil 05:32:23 INFO - building 'psutil._psutil_osx' extension 05:32:23 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 05:32:23 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 05:32:23 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 05:32:23 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 05:32:23 INFO - building 'psutil._psutil_posix' extension 05:32:23 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 05:32:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:23 INFO - ^ 05:32:24 INFO - 1 warning generated. 05:32:24 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 05:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:24 INFO - Successfully installed psutil 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:24 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')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 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')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:24 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 05:32:24 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 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:27 INFO - Installing collected packages: mozsystemmonitor 05:32:27 INFO - Running setup.py install for mozsystemmonitor 05:32:27 INFO - Successfully installed mozsystemmonitor 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:27 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')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:28 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:28 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 05:32:28 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 05:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:28 INFO - 'HOME': '/Users/cltbld', 05:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:28 INFO - 'LOGNAME': 'cltbld', 05:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:28 INFO - 'MOZ_NO_REMOTE': '1', 05:32:28 INFO - 'NO_EM_RESTART': '1', 05:32:28 INFO - 'PAGER': '/bin/cat', 05:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:28 INFO - 'PWD': '/builds/slave/test', 05:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:28 INFO - 'SHELL': '/bin/bash', 05:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:28 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:28 INFO - 'USER': 'cltbld', 05:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:28 INFO - 'XPC_FLAGS': '0x0', 05:32:28 INFO - 'XPC_SERVICE_NAME': '0', 05:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:28 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 05:32:28 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 05:32:28 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 05:32:28 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 05:32:28 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 05:32:28 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 05:32:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 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 05:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:31 INFO - warning: no files found matching '*.txt' 05:32:31 INFO - no previously-included directories found matching 'build' 05:32:31 INFO - no previously-included directories found matching 'dist' 05:32:31 INFO - no previously-included directories found matching '.git*' 05:32:31 INFO - Installing collected packages: jsonschema, functools32 05:32:31 INFO - Running setup.py install for functools32 05:32:31 INFO - warning: no files found matching '*.txt' 05:32:31 INFO - no previously-included directories found matching 'build' 05:32:31 INFO - no previously-included directories found matching 'dist' 05:32:31 INFO - no previously-included directories found matching '.git*' 05:32:31 INFO - Successfully installed jsonschema functools32 05:32:31 INFO - Cleaning up... 05:32:31 INFO - Return code: 0 05:32:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:31 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 05:32:31 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 05:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:31 INFO - 'HOME': '/Users/cltbld', 05:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:31 INFO - 'LOGNAME': 'cltbld', 05:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:31 INFO - 'MOZ_NO_REMOTE': '1', 05:32:31 INFO - 'NO_EM_RESTART': '1', 05:32:31 INFO - 'PAGER': '/bin/cat', 05:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:31 INFO - 'PWD': '/builds/slave/test', 05:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:31 INFO - 'SHELL': '/bin/bash', 05:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:31 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:31 INFO - 'USER': 'cltbld', 05:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:31 INFO - 'XPC_FLAGS': '0x0', 05:32:31 INFO - 'XPC_SERVICE_NAME': '0', 05:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:32 INFO - Cleaning up... 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:32 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:32 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 05:32:32 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 05:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:36 INFO - Downloading docopt-0.6.1.tar.gz 05:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:36 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:36 INFO - Running setup.py install for blobuploader 05:32:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:36 INFO - Running setup.py install for requests 05:32:36 INFO - Running setup.py install for docopt 05:32:37 INFO - Successfully installed blobuploader requests docopt 05:32:37 INFO - Cleaning up... 05:32:37 INFO - Return code: 0 05:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:37 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')]} 05:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:37 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')]} 05:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:37 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:37 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 05:32:37 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 05:32:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:37 INFO - 'HOME': '/Users/cltbld', 05:32:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:37 INFO - 'LOGNAME': 'cltbld', 05:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:37 INFO - 'MOZ_NO_REMOTE': '1', 05:32:37 INFO - 'NO_EM_RESTART': '1', 05:32:37 INFO - 'PAGER': '/bin/cat', 05:32:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:37 INFO - 'PWD': '/builds/slave/test', 05:32:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:37 INFO - 'SHELL': '/bin/bash', 05:32:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:37 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:37 INFO - 'USER': 'cltbld', 05:32:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:37 INFO - 'XPC_FLAGS': '0x0', 05:32:37 INFO - 'XPC_SERVICE_NAME': '0', 05:32:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-u8rOHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-6A2a__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-PyGyhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-FwPvA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-154or4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-F0oJ4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_ZXh6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-kLnYGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rtv5dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-CYv_ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-__zQFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tCufuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-zDfbws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-JBqpLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-n_apXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:39 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-KMyquT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:39 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Drmzf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:39 INFO - Running setup.py install for manifestparser 05:32:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozcrash 05:32:39 INFO - Running setup.py install for mozdebug 05:32:39 INFO - Running setup.py install for mozdevice 05:32:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozfile 05:32:39 INFO - Running setup.py install for mozhttpd 05:32:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozinfo 05:32:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozInstall 05:32:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozleak 05:32:40 INFO - Running setup.py install for mozlog 05:32:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for moznetwork 05:32:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozprocess 05:32:41 INFO - Running setup.py install for mozprofile 05:32:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozrunner 05:32:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozscreenshot 05:32:41 INFO - Running setup.py install for moztest 05:32:41 INFO - Running setup.py install for mozversion 05:32:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:41 INFO - Cleaning up... 05:32:41 INFO - Return code: 0 05:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:41 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')]} 05:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:41 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')]} 05:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:41 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:41 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 05:32:41 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 05:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:41 INFO - 'HOME': '/Users/cltbld', 05:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:41 INFO - 'LOGNAME': 'cltbld', 05:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:41 INFO - 'MOZ_NO_REMOTE': '1', 05:32:41 INFO - 'NO_EM_RESTART': '1', 05:32:41 INFO - 'PAGER': '/bin/cat', 05:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:41 INFO - 'PWD': '/builds/slave/test', 05:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:41 INFO - 'SHELL': '/bin/bash', 05:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:41 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:41 INFO - 'USER': 'cltbld', 05:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:41 INFO - 'XPC_FLAGS': '0x0', 05:32:41 INFO - 'XPC_SERVICE_NAME': '0', 05:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-OnXKkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-qy7qXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-OxCRlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-RhbFqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-6aKyPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-PKfOjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-F0P9XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ljnCz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:42 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-AHVqBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rrIAbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-M2F35z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-dvvpJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-JKpD6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-E74Tzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-KUN1Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_X9J3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:43 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-4varRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:43 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:46 INFO - Downloading blessings-1.6.tar.gz 05:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:46 INFO - Installing collected packages: blessings 05:32:46 INFO - Running setup.py install for blessings 05:32:46 INFO - Successfully installed blessings 05:32:46 INFO - Cleaning up... 05:32:46 INFO - Return code: 0 05:32:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:47 INFO - Reading from file tmpfile_stdout 05:32:47 INFO - Current package versions: 05:32:47 INFO - blessings == 1.6 05:32:47 INFO - blobuploader == 1.2.4 05:32:47 INFO - docopt == 0.6.1 05:32:47 INFO - functools32 == 3.2.3-2 05:32:47 INFO - jsonschema == 2.5.1 05:32:47 INFO - manifestparser == 1.1 05:32:47 INFO - mozInstall == 1.12 05:32:47 INFO - mozcrash == 1.0 05:32:47 INFO - mozdebug == 0.1 05:32:47 INFO - mozdevice == 0.50 05:32:47 INFO - mozfile == 1.2 05:32:47 INFO - mozhttpd == 0.7 05:32:47 INFO - mozinfo == 0.9 05:32:47 INFO - mozleak == 0.1 05:32:47 INFO - mozlog == 3.4 05:32:47 INFO - moznetwork == 0.27 05:32:47 INFO - mozprocess == 0.25 05:32:47 INFO - mozprofile == 0.28 05:32:47 INFO - mozrunner == 6.13 05:32:47 INFO - mozscreenshot == 0.1 05:32:47 INFO - mozsystemmonitor == 0.3 05:32:47 INFO - moztest == 0.8 05:32:47 INFO - mozversion == 1.4 05:32:47 INFO - psutil == 3.1.1 05:32:47 INFO - requests == 1.2.3 05:32:47 INFO - wsgiref == 0.1.2 05:32:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:47 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 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32:47 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 05:32:47 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 05:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:47 INFO - 'HOME': '/Users/cltbld', 05:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:47 INFO - 'LOGNAME': 'cltbld', 05:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:47 INFO - 'MOZ_NO_REMOTE': '1', 05:32:47 INFO - 'NO_EM_RESTART': '1', 05:32:47 INFO - 'PAGER': '/bin/cat', 05:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:47 INFO - 'PWD': '/builds/slave/test', 05:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:47 INFO - 'SHELL': '/bin/bash', 05:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:47 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:47 INFO - 'USER': 'cltbld', 05:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:47 INFO - 'XPC_FLAGS': '0x0', 05:32:47 INFO - 'XPC_SERVICE_NAME': '0', 05:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 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)) 05:32:47 INFO - Cleaning up... 05:32:47 INFO - Return code: 0 05:32:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10feabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff35addadf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, '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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 05:32: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'] in /builds/slave/test/build 05:32: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 05:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:47 INFO - 'HOME': '/Users/cltbld', 05:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:47 INFO - 'LOGNAME': 'cltbld', 05:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:47 INFO - 'MOZ_NO_REMOTE': '1', 05:32:47 INFO - 'NO_EM_RESTART': '1', 05:32:47 INFO - 'PAGER': '/bin/cat', 05:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:47 INFO - 'PWD': '/builds/slave/test', 05:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:47 INFO - 'SHELL': '/bin/bash', 05:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:32:47 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:47 INFO - 'USER': 'cltbld', 05:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:47 INFO - 'XPC_FLAGS': '0x0', 05:32:47 INFO - 'XPC_SERVICE_NAME': '0', 05:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:47 INFO - Cleaning up... 05:32:47 INFO - Return code: 0 05:32:47 INFO - Running post-action listener: _resource_record_post_action 05:32:47 INFO - Running post-action listener: _start_resource_monitoring 05:32:47 INFO - Starting resource monitoring. 05:32:47 INFO - [mozharness: 2017-05-02 12:32:47.745812Z] Finished create-virtualenv step (success) 05:32:47 INFO - [mozharness: 2017-05-02 12:32:47.746764Z] Running install step. 05:32:47 INFO - Running pre-action listener: _resource_record_pre_action 05:32:47 INFO - Running main action method: install 05:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:48 INFO - Reading from file tmpfile_stdout 05:32:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:48 INFO - Reading from file tmpfile_stdout 05:32:48 INFO - Output received: 05:32:48 INFO - Usage: mozinstall [options] installer 05:32:48 INFO - Options: 05:32:48 INFO - -h, --help show this help message and exit 05:32:48 INFO - -d DEST, --destination=DEST 05:32:48 INFO - Directory to install application into. [default: 05:32:48 INFO - "/builds/slave/test"] 05:32:48 INFO - --app=APP Application being installed. [default: firefox] 05:32:48 INFO - mkdir: /builds/slave/test/build/application 05:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:07 INFO - Reading from file tmpfile_stdout 05:33:07 INFO - Output received: 05:33:07 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:07 INFO - Running post-action listener: _resource_record_post_action 05:33:07 INFO - [mozharness: 2017-05-02 12:33:07.791835Z] Finished install step (success) 05:33:07 INFO - [mozharness: 2017-05-02 12:33:07.791971Z] Running run-tests step. 05:33:07 INFO - Running pre-action listener: _resource_record_pre_action 05:33:07 INFO - Running main action method: run_tests 05:33:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:07 INFO - 2017-05-02 05:33:07.806 screenresolution[2165:17942] starting screenresolution argv=screenresolution get 05:33:07 INFO - 2017-05-02 05:33:07.809 screenresolution[2165:17942] Display 0: 1600x1200x32@60 05:33:07 INFO - 2017-05-02 05:33:07.815 screenresolution[2166:17944] starting screenresolution argv=screenresolution list 05:33:07 INFO - Available Modes on Display 0 05:33:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:08 INFO - Intel Iris: 05:33:08 INFO - Chipset Model: Intel Iris 05:33:08 INFO - Type: GPU 05:33:08 INFO - Bus: Built-In 05:33:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:08 INFO - Vendor: Intel (0x8086) 05:33:08 INFO - Device ID: 0x0a2e 05:33:08 INFO - Revision ID: 0x0009 05:33:08 INFO - Displays: 05:33:08 INFO - Display: 05:33:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:08 INFO - Display Serial Number: 1600x1200 60 05:33:08 INFO - Main Display: Yes 05:33:08 INFO - Mirror: Off 05:33:08 INFO - Online: Yes 05:33:08 INFO - Rotation: Supported 05:33:08 INFO - Return code: 0 05:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:08 INFO - Python 2.7.3 05:33:08 INFO - Return code: 0 05:33:08 INFO - grabbing minidump binary from tooltool 05:33:08 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')]} 05:33:08 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 0x10fc89d30>, '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 0x10fbafdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:08 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 05:33:08 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 05:33:08 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 05:33:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:08 INFO - Return code: 0 05:33:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:08 INFO - ENV: RUST_BACKTRACE is now 1 05:33:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 05:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 05:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u1N5qE6cc7/Render', 05:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:08 INFO - 'HOME': '/Users/cltbld', 05:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:08 INFO - 'LOGNAME': 'cltbld', 05:33:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:08 INFO - 'MOZ_NO_REMOTE': '1', 05:33:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:08 INFO - 'NO_EM_RESTART': '1', 05:33:08 INFO - 'PAGER': '/bin/cat', 05:33:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:08 INFO - 'PWD': '/builds/slave/test', 05:33:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:08 INFO - 'RUST_BACKTRACE': '1', 05:33:08 INFO - 'SHELL': '/bin/bash', 05:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7wJoBkGZH/Listeners', 05:33:08 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 05:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:08 INFO - 'USER': 'cltbld', 05:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:08 INFO - 'XPC_FLAGS': '0x0', 05:33:08 INFO - 'XPC_SERVICE_NAME': '0', 05:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 05:33:08 INFO - mozversion application_buildid: 20170502030211 05:33:08 INFO - mozversion application_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 05:33:08 INFO - mozversion application_display_name: Nightly 05:33:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:08 INFO - mozversion application_name: Firefox 05:33:08 INFO - mozversion application_remotingname: firefox 05:33:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:08 INFO - mozversion application_vendor: Mozilla 05:33:08 INFO - mozversion application_version: 55.0a1 05:33:08 INFO - mozversion platform_buildid: 20170502030211 05:33:08 INFO - mozversion platform_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 05:33:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:08 INFO - mozversion platform_version: 55.0a1 05:33:08 INFO - using testdate: 1493728388 05:33:08 INFO - actual date: 1493728388 05:33:08 INFO - starting webserver on 'localhost:56077' 05:33:08 INFO - SUITE-START | Running 2 tests 05:33:08 INFO - TEST-START | dromaeo_css 05:33:08 INFO - operating with platform_type : mac_ 05:33:08 INFO - Initialising browser for dromaeo_css test... 05:33:08 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpv1D9M_/profile http://localhost:56077/getInfo.html) 05:33:11 INFO - PID 2176 | __metrics Screen width/height:1600/1200 05:33:11 INFO - PID 2176 | colorDepth:24 05:33:11 INFO - PID 2176 | Browser inner width/height: 1024/689 05:33:11 INFO - PID 2176 | __metrics 05:33:11 INFO - PID 2176 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:11 INFO - PID 2176 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:12 INFO - TEST-INFO | 2176: exit 0 05:33:12 INFO - Browser initialized. 05:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:12 INFO - TEST-INFO | started process 2179 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpv1D9M_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:24 INFO - PID 2179 | RSS: Main: 241139712 05:33:24 INFO - PID 2179 | 05:36:28 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56077/tests/dromaeo/cssquery-ext.html) 05:36:30 INFO - PID 2179 | RSS: Main: 402481152 05:36:30 INFO - PID 2179 | 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | A coding exception was thrown and uncaught in a Task. 05:38:14 INFO - PID 2179 | 05:38:14 ERROR - PID 2179 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:14 INFO - PID 2179 | Full stack: 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | A coding exception was thrown and uncaught in a Task. 05:38:14 INFO - PID 2179 | 05:38:14 ERROR - PID 2179 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:14 INFO - PID 2179 | Full stack: 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | A coding exception was thrown and uncaught in a Task. 05:38:14 INFO - PID 2179 | 05:38:14 ERROR - PID 2179 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:14 INFO - PID 2179 | Full stack: 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | ************************* 05:38:14 INFO - PID 2179 | A coding exception was thrown and uncaught in a Task. 05:38:14 INFO - PID 2179 | 05:38:14 ERROR - PID 2179 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:38:14 INFO - PID 2179 | Full stack: 05:38:14 INFO - PID 2179 | ************************* 05:39:33 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-ext.html (next: http://localhost:56077/tests/dromaeo/cssquery-jquery.html) 05:39:34 INFO - PID 2179 | RSS: Main: 367353856 05:39:34 INFO - PID 2179 | 05:42:36 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56077/tests/dromaeo/cssquery-mootools.html) 05:42:36 INFO - PID 2179 | RSS: Main: 326418432 05:42:36 INFO - PID 2179 | 05:45:39 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56077/tests/dromaeo/cssquery-prototype.html) 05:45:39 INFO - PID 2179 | RSS: Main: 324702208 05:45:39 INFO - PID 2179 | 05:48:43 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56077/tests/dromaeo/cssquery-yui.html) 05:48:44 INFO - PID 2179 | RSS: Main: 339234816 05:48:44 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | Cycle 1(1): loaded http://localhost:56077/tests/dromaeo/cssquery-yui.html (next: http://localhost:56077/tests/dromaeo/cssquery-dojo.html) 05:51:46 INFO - PID 2179 | RSS: Main: 377311232 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | __start_tp_report 05:51:46 INFO - PID 2179 | _x_x_mozilla_page_load 05:51:46 INFO - PID 2179 | _x_x_mozilla_page_load_details 05:51:46 INFO - PID 2179 | |i|pagename|runs| 05:51:46 INFO - PID 2179 | |0;dojo.html;3504.5268888700016;3532.604621174636;3568.8929332120038;3572.1605422725656;3581.194231297958;5996.670183139926;6111.938880611193;6267.968660156698;6271.560990730651;6276.6547839868845;6048.2137322148055;6061.939380606193;6070.271567411905;6088.512918966483;6106.755729770815;5196.246544251081;5236.2931004314405;5239.711815850127;5256.5794736421185;5316.6544174628525;5373.319276295731;5377.193420986844;5381.650192737459;5385.138377859544;5388.892222155555;5351.384590772072;5352.4915133062295;5356.785728570852;5370.812021579245;5373.435789242132;5336.573074154097;5340.893182136336;5344.038073146832;5347.224652425396;5361.088614935451;5220.582353411718;5273.2617433559335;5305.814296499642;5343.599230057723;5363.651362661414;6204.751809927598;6208.596441231305;6244.937550624481;6246.156768836195;6247.656378899159;6327.5570710050315;6441.291457939623;6450.548461607689;6460.095586617877;6494.220693516761;6033.456988871023;6448.355164483561;6463.450606698436;6482.870342593122;6516.2506311773805;5240.6069544784295;6362.522810789209;6365.458935990493;6384.425401713868;6398.936010639927;6766.391024807693;6771;6772.051912732221;6774.322567743285;6784.185897692309;6078.665673388006;6106.572539922252;6343.397377249154;6438.6136831790245;6451.064595633607;6443.226812782403;6475.158229430144;6522.184726909137;6555.344465553407;6614.801555953329;6434.774782882577;6452.1289625900845;6456.677166141674;6467.773627923;6472.352764723584;6416.807495775134;6443.452306553995;6463.15978922737;6488.772892948724;6495;5078.3905931287745;5135.229715542699;5253.106971814801;5258.447862974333;5267.868303292448;4684.1334353144775;4686.203345431285;4693.95306046942;4712;4731.7634118293945;6227.221597300338;6237.812865614039;6246.531510136758;6253.937460625336;6254.718537665816;6329.588576742497;6434.195725534309;6462.450691691165;6492.967535162294;6599.60402375859;6165.352637973038;6173.722182501709;6215.34738852423;6220.720067596969;6221.191245138103;5712.143178523172;5712.885742285131;5733.455321744427;5746.88506229873;5770.451807078321;6564.770233041821;6597.505187111082;6714.160729908762;6794.72821087151;6800.047993280846;5824.592278540462;6579.835504112435;6610.933890661032;6627.966860165669;6636.236832764101;6760.526763126534;6806.18325800907;6816.0457535944015;6826.419754320938;6842.692078856563;4986.276989836526;6329.208848893888;6429.164208653032;6449.774257900951;6522.021696745336;6555.6066636002;6558.80323590293;6594.736210551524;6600.570962887397;6618.70215840298;6414.102025716496;6421.325760795049;6430.485561155003;6439.613623182624;6456.870862582628;6251.281102673069;6311.652859092794;6332.366763323631;6333.746650133943;6416.839579010375;6259.311475737574;6280.183576135073;6305.905411418924;6309.400606942333;6316.715747791269;6387.265464471645;6404.615723056631;6419.935800642121;6443.9355606445215;6452.387023232785;6304.5271604628915;6354.046892965907;6360.332165122595;6364.93635063662;6369.9681501592195 05:51:46 INFO - PID 2179 | |1;ext.html;789.6407134753688;802.7471346525844;1117.4133579870568;1132.4507613807298;1144.7653231087634;32353;35465.468017979685;35518.75684351045;35715;35750;37516.43725344122;37521;37545.62454375455;37603.3594960756;37667.24665506688;5802.419758024185;8112.999999999985;8229;8241.340692744567;8248.010238771356;5809.506191973687;8076.071251806059;8199.549024803633;8223.917760822405;8236.876446853303;7029.683664235096;8305.626246818907;8310.667573297062;8323.209295116954;8346.165383461666;5873.618214816023;8240.958795206016;8280.627371768254;8285.42002059856;8318.875216871751;5827.941720582782;7889.447738658297;7995.000624921885;8009.719659811879;8027.2775450209765;35656;35969.280614387826;36014.27971440583;36014.81992590046;36212.09469763277;3526;3554.36021516127;3564.287142571496;3564.8752293669854;3568.3220188164164;29580;29629.11112666602;29660;29754.80980760767;29775.808967641267;3094.102710214058;3134.3104517006223;3159.605049368829;3174.1747145742042;3180.5865237519206;256929;295932;296564;297007;300199;38001.80999095042;38583.61416385856;47358.052838943026;47501.76249118732;47685.76157119262;40648;48757.756211218715;49272;49301;49342.75328623406;12226.510939562495;13542;13657.248851313274;13662.863371366358;13678.452861885413;10582.259241852997;11146.944265278622;11164.162687798447;11170.994610485095;11197.272177308449;12509.249445033327;12521.74956500865;12567.18313309632;12572.119951603483;12672.49310027607;5161.845144645667;5207.479252074838;5208.5051920067535;5208.609354298443;5217.791288348423;972.863799068131;1008.4201584089178;1018.4856647393167;1057.6086847866338;1060.1730650092786;22820.201292954665;23993.760062399153;24123.638145427834;24132.091447925348;24367.26898193057;961.6105477281712;1000.3747657713928;1107.191750022472;1114.1365441782684;1128.2835399521364;9182.908170918205;11647.41762911851;12145.271283723005;12208.023358131328;12227.938860305641;297314;299527;300411.49794251326;301754.9649007008;301757.49121254694;51228.48771512312;51422;51425.7428712854;51434.228486572734;51545.48454515482;1465.4577806211769;1481.8518148185094;1481.977770333446;1529.350026238844;1530.1584128729155;23414.765852341257;23494.412639684146;23529.882350588137;23577.056917723097;23697;29706.851465742533;31059.37881242408;37730.811345944196;37838.24323513459;37983.62016379911;282532;284098;284161;284200.15799842565;284728;29262.853685731436;29957.400851982402;33316.83341583276;33757.3248535023;33920.25116483645;40907;42438.57561424346;42499.362509563;42505.78747106368;42634.360484592136;28050.877964881176;28778.568321474777;29007.274818129714;29823.403531929675;29967.951121710634;26077.478450430506;29450;29623.555646665747;29728.702712972594;29929.401411972074;34373;34465.655343447244;35081.473777893865;35889;35897.64102358943;29165.416691665625;29430.558541622322;29902.252443688212;29958.35372369706;30063.947761829106;17218.741718874477;23047.769522304563;23366.94848731777;23383.298501044996;23629.88185059064 05:51:46 INFO - PID 2179 | |2;jquery.html;359.5810880324422;422.0338009837885;433.43220381300506;434.73046711039154;452.45253243575274;19298.90350548247;20758;21236.68144977823;21481.03335349909;21512.56974860502;21814.563708725815;22663.433414164654;23231.883840580816;23372.76627233727;23417.882910585467;6039.486643635296;6276.748930042792;6289.308176100625;6305.369463053681;6306.306306306303;5881.206037184989;6108.236470441195;6153.077038444225;6170.7223174957235;6185.690715464231;5896.439838215363;6105.908411373833;6120.69396530174;6124.663143527104;6128.96935515324;6032.396760323976;6165;6177.166082578839;6179.907301390483;6189.319174890758;5284.365876094893;5422.9728851355885;5498.3127109111365;5517.089680202762;5528.530074943635;26933.865330673416;27089.458210835674;27294.5905811413;27945;27975.58036629452;2144.345974477784;2163.3618082665653;2189.27753841232;2217.866927984326;2230.631945728953;17218.31126754928;17251.913740431217;17927.551811204823;18218.45344639663;18389.356372526898;1742.35532852844;2141.250562303197;2183.115838085562;2183.585118827418;2189.1243502598927;140597.2970135153;141434;143417;143884;144385.99999999895;11790.705232369259;12225.742930539775;12299.93850030744;12336.62990110298;12384.75230495385;16284.837151628331;16333.183340832911;16368.83631163697;16384.344626215057;16418.83581164173;8621.482711037232;8752.905886764154;8864.335174861912;8936.731898042939;8997.955010224907;7052.753153639598;7164.964175179195;8320.500769953822;8381.580920953927;8462.576871156542;7629.465937384441;7680.846383072419;7717.614119294013;7832.451728378959;7839.921600784033;2125.4155107345296;2129.7444306683296;2130.850840441154;2140.486283291999;2309.1686992682958;898.4250079948838;912.4570880326195;921.6543796076471;968.6222373274429;969.6606187834202;20819.58360832775;20865;20890.686639700416;20896.268630597857;21008.684869726967;818.2676504528414;954.2517549457518;978.9021097890154;988.683621241196;990.2372381056915;7920.960395197987;10906.127509799197;13268.93365533166;13820.585382438543;14089.09797177368;551913;557878;562266;562927;564466;101264.49367753262;123085.92168213762;123122.15316770256;127543;132275;1166.2477701882237;1169.3101070368523;1212.799888018467;1217.8538575371012;1220.3593113615423;17787.73318400199;21399;22336.888315558317;22407.887960560092;22586.435339115997;45684.77157614191;57306;57717;57910.7104464475;58120.2563923083;75885.62057189678;77599.07610624624;79491.60254198693;81392.77910831224;81841.77237341563;8772.078931712078;8835.71882077108;8839.248663863644;9182.632694692138;9363.204127649225;14599.562013139623;14759.704805904037;14916.627084322545;15027.398904044154;15164.165970871709;11258.943705281748;12152.513899443924;12211.633650990485;12216.572419965258;12282.201656892274;10242.334248273839;10498.317609355367;11470.369129697612;11780.646580602595;11788.705282367666;12328.81506777417;12340.629781106582;12495.93752031234;12679.23924564529;12780.169288996558;8158.3473322132895;9043.32175086858;9067.773305667411;9093.090690930854;9355.532223388667;12109.69725756863;12127.696807579881;12382.504699811907;12422.751544969231;12456.377181141088 05:51:46 INFO - PID 2179 | |3;mootools.html;1184.591315995982;1217.896478799302;1407.6691977385312;1421.3319739722326;1423.4590855474914;9574.904250957488;9713.514324283775;11013.669589912306;11687.766244675102;11700.707482312957;11297.774044519105;11395.259308144965;11397.202195846294;11419.200655954066;11463.942680286587;2081.188336548747;2393.617021276596;2436.6954130733657;2438.2807071913826;2440.6217036359394;2149.4196566927;2417.2627348658652;2524.5960646296594;2542.2373288013614;2542.377117606189;2439.6828412306377;2463.6427717980882;2488.079410618074;2489.0914816092177;2489.128804918273;2456.570100232452;2465.285067330472;2488.365466805953;2488.713797913236;2495.9750402495924;2452.2398056602333;2455.2020593307248;2460.4463995601027;2461.655368248447;2461.9876900615563;11007.779844403147;11103.72240693981;11116.722081947935;11118.22172447929;11127.998480136746;5244.554212891909;6430.646314452703;6512;6518.152640156797;6520.902186467207;3805.809709514541;4040.939385909214;4173.624373806341;4193;4203.726757760766;1252.3863306979606;1253.9749205015848;1286.4468278640181;1298.2340419152745;1303.172485471723;15514.5345639631;15880.444184453489;15881.761773573406;15907.0455772654;15907.840921590752;4581.816727330936;5146.408163061295;5622.297212848394;5662.631928924607;5902.76388944446;13151.539696110782;13152.802707959388;13176.47294108244;13180.736385272241;13181.143225690299;6459.321771214049;6581.539292249592;6599.274079851212;6608.2730899601;6611.140551728245;5829.213056237354;6091.329953705089;6096.634201947897;6133.3866613338305;6236.314005459396;3702.500162478031;4198.097409057067;4310;4339.3924850520325;4340.891477713082;1258.7545428641326;1260.0738457233927;1270.4664041102758;1276.0812215205037;1278.1947373154853;792.6750032486652;811.6144831205248;824.826786374868;828.353883970504;854;4695.85912422621;6012.428819262163;6014.909776353358;6047.848803779941;6315.421144713821;586.7418335932176;602.193061297863;608.8051823416553;610.6763415389851;611.9510439164856;3329.0012996101073;4300.591443812833;4310.956890431118;4373.2128216921255;4494.348319493655;14206.644833879029;14330.856691432953;14450.205238711971;14715.852841471662;14732.337044833008;14074.577762667137;14660.706785864222;14665.266736663338;14670.926645366919;14678.972471927076;8163.224493673091;8451.915480845235;8548.358873084419;8558.871616925751;8569.78575535604;5233.555147812479;6844.178698556205;6999.755008574675;7030.753923612649;7035.401990830836;12851.421686023965;12890.226586404846;12932.870671293167;13044.086913915935;13246.933765331112;10982.890171098506;12252.75494490123;13532.188068715908;13548.661283467993;13576.253306068262;6643.534952553468;8253.752387428387;9215.2627789778;9219.03200163973;9231.123043310874;10292.742681433025;10429.061384475433;10466.215033872642;10471.214658900766;10568.20738444635;8726.956365218133;8868.467891926504;8915.465072095694;8925.196732293865;9081.68214112503;8592.570371481275;8725.607347669496;8799.956000219958;8829.911700882909;8833.867491987754;7978.84042319162;8119.634616442392;8139.104698483044;8139.715109971123;8141.0230772307705;5837.562182836219;5871.794487192928;6002.789902353396;6081.239845019372;6108.5723999319625;5518.227448157341;5936.347001829881;6142.723577438936;6148.354422785543;6152.908011276188 05:51:46 INFO - PID 2179 | |4;prototype.html;395.9782211978341;398.2453251089186;403.65487508180513;405.29883301887713;410.8028146489683;5144.17693169093;5434.483724046214;5793.768249270024;5824.213731146294;5851.561132915027;5488.890222195564;5575.442455754423;5617.606767526275;5673.546116310696;5729;4357.978210108961;4370.912581748363;4383.167198232326;4396.428464299636;4403.367222041828;4396.164728701552;4396.230659634567;4396.406485124499;4416.536263692315;4428.40216570762;3576.92846143077;3805.82873770681;4310.159518893817;4341.891452713691;4383.978080109595;4329.891752706176;4338.43600331958;4344.261475549164;4356.673249506284;4358.694891357606;3874.9731321199906;3889.747166434173;3919.804009799527;3934.350832112698;3935.1736135411597;4632.606228470584;5457.962987032491;5506.366767821712;5606.775728970836;5643.435656434365;5203.089459344599;5270.417495427251;5275.072334854154;5301.125314323132;5304.549113325372;6138.386161383871;6153.7230824613;6178.41305076017;6203.96898015507;6206.627602343874;3851.7496362736333;4066.837326506966;4083.203775263825;4096.938545921784;4112.383142528614;5558.832645144484;5561.666300021971;6232.345603711636;6385.904211436832;6489.740410383579;4007.1785284016705;4016.116454380032;4117.032497363117;4124.52567954683;4133.46264985556;3982.4424580558743;4181.686373521937;4189.72766770159;4193.6645068394455;4217.557156498524;4264.552222016706;4718.811247550128;4776.402949631296;4858.076965376567;4878.682885612424;5045.520675535819;6081.391860813883;6089.985457198626;6090.512758979271;6151.077338399186;1367.459853357918;1403.7473254814026;1417.5038736442164;1424.4871846135384;1425.9001869869217;906.2976193450129;935.8175155844544;938.9295802814817;943.5140902435252;950.7623094226443;5787.668836167621;5804.8653726987795;5838.416158384212;5857.301382598998;5862.299933019462;5320.946790532123;5985.760569577255;6237.500999919996;6264.1856558648;6336.398042185985;4880.389951256093;4888.60891128716;5320.521153096162;5550.363577300831;5734.853029394138;2711.928788128678;2808.803383763117;3106.7980581262145;3277.2789986202997;3299.191698033997;6320.778772742932;6367.61794292344;6454.612723236621;6483.286838447767;6498.54510184292;6451.516136289797;6463.385978332051;6465.450436712932;6503.154589903283;6519.641419721961;6193.345925903738;6391.392817682313;6417.358264173546;6499.935000649933;6554.147960765165;5320.701165277553;6255.499560035278;6298.622082675054;6299.275583307978;6373.948298530876;4929.457759646508;5182.352205974254;5711.543076553782;6229.345918678474;6236.688165591793;6186.659733714509;6348.587341822767;6494.480441564758;6503.512236582181;6517.902231466626;3746.875937218878;3860.613938606117;4076.2662720709372;4108.835646574224;4112.979435102805;5046.914913293659;5778.479936805707;5837.124431335334;6318.589291696025;6330.778422755181;5078.949210507995;5128.384488935366;6104.4505994460715;6118.479929206067;6145.354737752472;5840.503557197686;6038.909416358671;6068.453839154321;6120.632762034292;6142.170806941006;5796.82609521715;5973.790917317873;6003.879922401615;6026.849328766816;6040.75836966534;4828.444728856086;5886.38192989747;6136.386361363828;6160.537959652955;6178.876422471615;4597.586217240464;5697.772089116389;5713.914551095986;5906.557008224487;5964.522838173022 05:51:46 INFO - PID 2179 | |5;yui.html;711.6335087429977;861.3109512390087;867.1631875240396;871.0070519607648;881.5195718333507;13024;18311.267549298027;18395.72406413905;18655.626887462244;18831.340903068394;16790.244439000242;18019.549511262227;18422.26310947564;18453.907730461364;18588.34940777073;956.9856452153241;979.4123525884448;983.7393090830935;984.1388784813288;988.5205675247499;686.8591938652564;706.8974998625197;828.2918105020211;993.5975929748428;1016.2479764973903;1024.8462730590397;1026.8305729554652;1027.0499787696351;1029.0584115534277;1061.8460323253123;1026.3841694983025;1026.4457193115784;1033.0650761061213;1033.3593172233263;1073.624231518966;749.8050506868199;758.5751978891839;762.3253420722644;769.6805825582377;798.1380109481746;16752.078635675032;16941.407050753165;17103.23035463407;17461.03964281964;17638.911805441017;16920.830791692173;16974.15129243533;17443.30226790927;17446.56383590408;17512.949223046657;13835;13864.237466939314;13981;14215.928920355436;14227.715445691028;3460.619331873492;3495.2834668892815;3495.5106285120105;3496.667816557423;3496.667816557423;130020.34989825085;130213;131845.34077329648;131950.3609927796;132542;11020.118390528738;11341.149413793999;13163.53927612548;13241.205527668371;13243.470261189637;19596.608067838562;25020.749792502207;25392.365190870005;25602.103926362488;25782.226533204033;7764.805879853049;7885.329746971572;7941.444098913021;7946.086200086948;7950.324222441157;3910.4329872168946;3955.940660890089;4002.459667944848;4006.3790112532606;4014.1770936957855;4173.9582604174175;4241.088166044254;4255.1915136124035;4269.829206831692;4270.807813648331;929.8977112517617;934.4019827310391;943.8537026760863;948.137195152408;949.5916755794937;652.6182183422655;667.89981502774;683.2757277286092;687.2131409536054;704.7568588836843;11073.169512286611;11342.659720208407;11372.14708896836;11830.940845295718;11859.762804743857;656.5305806348483;661.0777964739162;670.7201783279766;672.3343889549311;678.7352932356386;5472.616916815785;5967.701614919323;6027.6986150693165;6031.155638210654;6068.757249709962;90585;91247.81932787817;105482;107900.46049769857;108061.45969270103;92221;92929.53535232281;94593.0540694598;94939.52530237305;94987.52506237425;83286;83317.16682833215;85720.57139714262;85980.57009714912;86411;12099.395030248628;12413.44139513706;12461.875381246435;12488.812667810173;12515.186512876633;34318.31363372769;40975.59024409837;41906;42031;42230;37918.81040594779;47908;54420;54483.72758136184;55099.44900550943;16394.508164755076;17018.404355847983;17239.310427582757;17334.04662743561;17343.132843358035;17764.55588610295;18086.90956545209;18105.185266662767;18670.43988680342;18738.531536711693;16503.422380217115;17028.574285642957;17352.91323543374;17633.64732705313;17695.46913592594;16870.409535666193;17200.741988869926;17386.826131738522;17656.20547075359;17818.10909454548;16462.917685411496;17262.913685431493;17270.913645431694;17367.392141274995;17440.953542787473;11719.648410547697;11791.35147566892;12102;12221.511139554319;12466.439010244741;13026;13494.865051349361;14137.646558836112;14182.574522764333;14240.572782816533 05:51:46 INFO - PID 2179 | __end_tp_report 05:51:46 INFO - PID 2179 | __start_cc_report 05:51:46 INFO - PID 2179 | _x_x_mozilla_cycle_collect,2311 05:51:46 INFO - PID 2179 | __end_cc_report 05:51:46 INFO - PID 2179 | __startTimestamp1493729506593__endTimestamp 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | ------- Summary: start ------- 05:51:46 INFO - PID 2179 | Number of tests: 6 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#0] dojo.html Cycles:165 Average:6036.76 Median:6311.65 stddev:696.56 (11.0%) stddev-sans-first:669.78 05:51:46 INFO - PID 2179 | Values: 3504.5 3532.6 3568.9 3572.2 3581.2 5996.7 6111.9 6268.0 6271.6 6276.7 6048.2 6061.9 6070.3 6088.5 6106.8 5196.2 5236.3 5239.7 5256.6 5316.7 5373.3 5377.2 5381.7 5385.1 5388.9 5351.4 5352.5 5356.8 5370.8 5373.4 5336.6 5340.9 5344.0 5347.2 5361.1 5220.6 5273.3 5305.8 5343.6 5363.7 6204.8 6208.6 6244.9 6246.2 6247.7 6327.6 6441.3 6450.5 6460.1 6494.2 6033.5 6448.4 6463.5 6482.9 6516.3 5240.6 6362.5 6365.5 6384.4 6398.9 6766.4 6771.0 6772.1 6774.3 6784.2 6078.7 6106.6 6343.4 6438.6 6451.1 6443.2 6475.2 6522.2 6555.3 6614.8 6434.8 6452.1 6456.7 6467.8 6472.4 6416.8 6443.5 6463.2 6488.8 6495.0 5078.4 5135.2 5253.1 5258.4 5267.9 4684.1 4686.2 4694.0 4712.0 4731.8 6227.2 6237.8 6246.5 6253.9 6254.7 6329.6 6434.2 6462.5 6493.0 6599.6 6165.4 6173.7 6215.3 6220.7 6221.2 5712.1 5712.9 5733.5 5746.9 5770.5 6564.8 6597.5 6714.2 6794.7 6800.0 5824.6 6579.8 6610.9 6628.0 6636.2 6760.5 6806.2 6816.0 6826.4 6842.7 4986.3 6329.2 6429.2 6449.8 6522.0 6555.6 6558.8 6594.7 6600.6 6618.7 6414.1 6421.3 6430.5 6439.6 6456.9 6251.3 6311.7 6332.4 6333.7 6416.8 6259.3 6280.2 6305.9 6309.4 6316.7 6387.3 6404.6 6419.9 6443.9 6452.4 6304.5 6354.0 6360.3 6364.9 6370.0 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#1] ext.html Cycles:180 Average:43324.90 Median:3146.96 stddev:76443.50 (2429.1%) stddev-sans-first:76591.23 05:51:46 INFO - PID 2179 | Values: 789.6 802.7 1117.4 1132.5 1144.8 32353.0 35465.5 35518.8 35715.0 35750.0 37516.4 37521.0 37545.6 37603.4 37667.2 5802.4 8113.0 8229.0 8241.3 8248.0 5809.5 8076.1 8199.5 8223.9 8236.9 7029.7 8305.6 8310.7 8323.2 8346.2 5873.6 8241.0 8280.6 8285.4 8318.9 5827.9 7889.4 7995.0 8009.7 8027.3 35656.0 35969.3 36014.3 36014.8 36212.1 3526.0 3554.4 3564.3 3564.9 3568.3 29580.0 29629.1 29660.0 29754.8 29775.8 3094.1 3134.3 3159.6 3174.2 3180.6 256929.0 295932.0 296564.0 297007.0 300199.0 38001.8 38583.6 47358.1 47501.8 47685.8 40648.0 48757.8 49272.0 49301.0 49342.8 12226.5 13542.0 13657.2 13662.9 13678.5 10582.3 11146.9 11164.2 11171.0 11197.3 12509.2 12521.7 12567.2 12572.1 12672.5 5161.8 5207.5 5208.5 5208.6 5217.8 972.9 1008.4 1018.5 1057.6 1060.2 22820.2 23993.8 24123.6 24132.1 24367.3 961.6 1000.4 1107.2 1114.1 1128.3 9182.9 11647.4 12145.3 12208.0 12227.9 297314.0 299527.0 300411.5 301755.0 301757.5 51228.5 51422.0 51425.7 51434.2 51545.5 1465.5 1481.9 1482.0 1529.4 1530.2 23414.8 23494.4 23529.9 23577.1 23697.0 29706.9 31059.4 37730.8 37838.2 37983.6 282532.0 284098.0 284161.0 284200.2 284728.0 29262.9 29957.4 33316.8 33757.3 33920.3 40907.0 42438.6 42499.4 42505.8 42634.4 28050.9 28778.6 29007.3 29823.4 29968.0 26077.5 29450.0 29623.6 29728.7 29929.4 34373.0 34465.7 35081.5 35889.0 35897.6 29165.4 29430.6 29902.3 29958.4 30063.9 17218.7 23047.8 23366.9 23383.3 23629.9 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#2] jquery.html Cycles:180 Average:35436.28 Median:12770.53 stddev:94211.83 (737.7%) stddev-sans-first:94439.30 05:51:46 INFO - PID 2179 | Values: 359.6 422.0 433.4 434.7 452.5 19298.9 20758.0 21236.7 21481.0 21512.6 21814.6 22663.4 23231.9 23372.8 23417.9 6039.5 6276.7 6289.3 6305.4 6306.3 5881.2 6108.2 6153.1 6170.7 6185.7 5896.4 6105.9 6120.7 6124.7 6129.0 6032.4 6165.0 6177.2 6179.9 6189.3 5284.4 5423.0 5498.3 5517.1 5528.5 26933.9 27089.5 27294.6 27945.0 27975.6 2144.3 2163.4 2189.3 2217.9 2230.6 17218.3 17251.9 17927.6 18218.5 18389.4 1742.4 2141.3 2183.1 2183.6 2189.1 140597.3 141434.0 143417.0 143884.0 144386.0 11790.7 12225.7 12299.9 12336.6 12384.8 16284.8 16333.2 16368.8 16384.3 16418.8 8621.5 8752.9 8864.3 8936.7 8998.0 7052.8 7165.0 8320.5 8381.6 8462.6 7629.5 7680.8 7717.6 7832.5 7839.9 2125.4 2129.7 2130.9 2140.5 2309.2 898.4 912.5 921.7 968.6 969.7 20819.6 20865.0 20890.7 20896.3 21008.7 818.3 954.3 978.9 988.7 990.2 7921.0 10906.1 13268.9 13820.6 14089.1 551913.0 557878.0 562266.0 562927.0 564466.0 101264.5 123085.9 123122.2 127543.0 132275.0 1166.2 1169.3 1212.8 1217.9 1220.4 17787.7 21399.0 22336.9 22407.9 22586.4 45684.8 57306.0 57717.0 57910.7 58120.3 75885.6 77599.1 79491.6 81392.8 81841.8 8772.1 8835.7 8839.2 9182.6 9363.2 14599.6 14759.7 14916.6 15027.4 15164.2 11258.9 12152.5 12211.6 12216.6 12282.2 10242.3 10498.3 11470.4 11780.6 11788.7 12328.8 12340.6 12495.9 12679.2 12780.2 8158.3 9043.3 9067.8 9093.1 9355.5 12109.7 12127.7 12382.5 12422.8 12456.4 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#3] mootools.html Cycles:180 Average:6911.67 Median:3923.37 stddev:4390.50 (111.9%) stddev-sans-first:4381.72 05:51:46 INFO - PID 2179 | Values: 1184.6 1217.9 1407.7 1421.3 1423.5 9574.9 9713.5 11013.7 11687.8 11700.7 11297.8 11395.3 11397.2 11419.2 11463.9 2081.2 2393.6 2436.7 2438.3 2440.6 2149.4 2417.3 2524.6 2542.2 2542.4 2439.7 2463.6 2488.1 2489.1 2489.1 2456.6 2465.3 2488.4 2488.7 2496.0 2452.2 2455.2 2460.4 2461.7 2462.0 11007.8 11103.7 11116.7 11118.2 11128.0 5244.6 6430.6 6512.0 6518.2 6520.9 3805.8 4040.9 4173.6 4193.0 4203.7 1252.4 1254.0 1286.4 1298.2 1303.2 15514.5 15880.4 15881.8 15907.0 15907.8 4581.8 5146.4 5622.3 5662.6 5902.8 13151.5 13152.8 13176.5 13180.7 13181.1 6459.3 6581.5 6599.3 6608.3 6611.1 5829.2 6091.3 6096.6 6133.4 6236.3 3702.5 4198.1 4310.0 4339.4 4340.9 1258.8 1260.1 1270.5 1276.1 1278.2 792.7 811.6 824.8 828.4 854.0 4695.9 6012.4 6014.9 6047.8 6315.4 586.7 602.2 608.8 610.7 612.0 3329.0 4300.6 4311.0 4373.2 4494.3 14206.6 14330.9 14450.2 14715.9 14732.3 14074.6 14660.7 14665.3 14670.9 14679.0 8163.2 8451.9 8548.4 8558.9 8569.8 5233.6 6844.2 6999.8 7030.8 7035.4 12851.4 12890.2 12932.9 13044.1 13246.9 10982.9 12252.8 13532.2 13548.7 13576.3 6643.5 8253.8 9215.3 9219.0 9231.1 10292.7 10429.1 10466.2 10471.2 10568.2 8727.0 8868.5 8915.5 8925.2 9081.7 8592.6 8725.6 8800.0 8829.9 8833.9 7978.8 8119.6 8139.1 8139.7 8141.0 5837.6 5871.8 6002.8 6081.2 6108.6 5518.2 5936.3 6142.7 6148.4 6152.9 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#4] prototype.html Cycles:180 Average:4930.06 Median:5560.25 stddev:1530.27 (27.5%) stddev-sans-first:1496.24 05:51:46 INFO - PID 2179 | Values: 396.0 398.2 403.7 405.3 410.8 5144.2 5434.5 5793.8 5824.2 5851.6 5488.9 5575.4 5617.6 5673.5 5729.0 4358.0 4370.9 4383.2 4396.4 4403.4 4396.2 4396.2 4396.4 4416.5 4428.4 3576.9 3805.8 4310.2 4341.9 4384.0 4329.9 4338.4 4344.3 4356.7 4358.7 3875.0 3889.7 3919.8 3934.4 3935.2 4632.6 5458.0 5506.4 5606.8 5643.4 5203.1 5270.4 5275.1 5301.1 5304.5 6138.4 6153.7 6178.4 6204.0 6206.6 3851.7 4066.8 4083.2 4096.9 4112.4 5558.8 5561.7 6232.3 6385.9 6489.7 4007.2 4016.1 4117.0 4124.5 4133.5 3982.4 4181.7 4189.7 4193.7 4217.6 4264.6 4718.8 4776.4 4858.1 4878.7 5045.5 6081.4 6090.0 6090.5 6151.1 1367.5 1403.7 1417.5 1424.5 1425.9 906.3 935.8 938.9 943.5 950.8 5787.7 5804.9 5838.4 5857.3 5862.3 5320.9 5985.8 6237.5 6264.2 6336.4 4880.4 4888.6 5320.5 5550.4 5734.9 2711.9 2808.8 3106.8 3277.3 3299.2 6320.8 6367.6 6454.6 6483.3 6498.5 6451.5 6463.4 6465.5 6503.2 6519.6 6193.3 6391.4 6417.4 6499.9 6554.1 5320.7 6255.5 6298.6 6299.3 6373.9 4929.5 5182.4 5711.5 6229.3 6236.7 6186.7 6348.6 6494.5 6503.5 6517.9 3746.9 3860.6 4076.3 4108.8 4113.0 5046.9 5778.5 5837.1 6318.6 6330.8 5078.9 5128.4 6104.5 6118.5 6145.4 5840.5 6038.9 6068.5 6120.6 6142.2 5796.8 5973.8 6003.9 6026.8 6040.8 4828.4 5886.4 6136.4 6160.5 6178.9 4597.6 5697.8 5713.9 5906.6 5964.5 05:51:46 INFO - PID 2179 | 05:51:46 INFO - PID 2179 | [#5] yui.html Cycles:180 Average:21998.81 Median:18663.03 stddev:31133.42 (166.8%) stddev-sans-first:31179.72 05:51:46 INFO - PID 2179 | Values: 711.6 861.3 867.2 871.0 881.5 13024.0 18311.3 18395.7 18655.6 18831.3 16790.2 18019.5 18422.3 18453.9 18588.3 957.0 979.4 983.7 984.1 988.5 686.9 706.9 828.3 993.6 1016.2 1024.8 1026.8 1027.0 1029.1 1061.8 1026.4 1026.4 1033.1 1033.4 1073.6 749.8 758.6 762.3 769.7 798.1 16752.1 16941.4 17103.2 17461.0 17638.9 16920.8 16974.2 17443.3 17446.6 17512.9 13835.0 13864.2 13981.0 14215.9 14227.7 3460.6 3495.3 3495.5 3496.7 3496.7 130020.3 130213.0 131845.3 131950.4 132542.0 11020.1 11341.1 13163.5 13241.2 13243.5 19596.6 25020.7 25392.4 25602.1 25782.2 7764.8 7885.3 7941.4 7946.1 7950.3 3910.4 3955.9 4002.5 4006.4 4014.2 4174.0 4241.1 4255.2 4269.8 4270.8 929.9 934.4 943.9 948.1 949.6 652.6 667.9 683.3 687.2 704.8 11073.2 11342.7 11372.1 11830.9 11859.8 656.5 661.1 670.7 672.3 678.7 5472.6 5967.7 6027.7 6031.2 6068.8 90585.0 91247.8 105482.0 107900.5 108061.5 92221.0 92929.5 94593.1 94939.5 94987.5 83286.0 83317.2 85720.6 85980.6 86411.0 12099.4 12413.4 12461.9 12488.8 12515.2 34318.3 40975.6 41906.0 42031.0 42230.0 37918.8 47908.0 54420.0 54483.7 55099.4 16394.5 17018.4 17239.3 17334.0 17343.1 17764.6 18086.9 18105.2 18670.4 18738.5 16503.4 17028.6 17352.9 17633.6 17695.5 16870.4 17200.7 17386.8 17656.2 17818.1 16462.9 17262.9 17270.9 17367.4 17441.0 11719.6 11791.4 12102.0 12221.5 12466.4 13026.0 13494.9 14137.6 14182.6 14240.6 05:51:46 INFO - PID 2179 | -------- Summary: end -------- 05:51:46 INFO - PID 2179 | 05:51:47 INFO - TEST-INFO | 2179: exit 0 05:51:47 INFO - TEST-OK | dromaeo_css | took 1118905ms 05:51:47 INFO - TEST-START | kraken 05:51:47 INFO - operating with platform_type : mac_ 05:51:47 INFO - Initialising browser for kraken test... 05:51:47 INFO - TEST-INFO | started process 2298 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpNktQ88/profile http://localhost:56077/getInfo.html) 05:51:49 INFO - PID 2298 | __metrics Screen width/height:1600/1200 05:51:49 INFO - PID 2298 | colorDepth:24 05:51:49 INFO - PID 2298 | Browser inner width/height: 1024/689 05:51:49 INFO - PID 2298 | __metrics 05:51:49 INFO - PID 2298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:51:49 INFO - PID 2298 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:50 INFO - TEST-INFO | 2298: exit 0 05:51:50 INFO - Browser initialized. 05:51:50 INFO - Running cycle 1/1 for kraken test... 05:51:50 INFO - TEST-INFO | started process 2300 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpNktQ88/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:03 INFO - PID 2300 | RSS: Main: 241840128 05:52:03 INFO - PID 2300 | 05:52:05 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56077/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:06 INFO - PID 2300 | RSS: Main: 310771712 05:52:06 INFO - PID 2300 | 05:52:09 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56077/tests/kraken/driver.html?testName=audio-dft) 05:52:09 INFO - PID 2300 | RSS: Main: 295358464 05:52:09 INFO - PID 2300 | 05:52:13 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56077/tests/kraken/driver.html?testName=audio-fft) 05:52:13 INFO - PID 2300 | RSS: Main: 385830912 05:52:13 INFO - PID 2300 | 05:52:15 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56077/tests/kraken/driver.html?testName=audio-oscillator) 05:52:16 INFO - PID 2300 | RSS: Main: 289390592 05:52:16 INFO - PID 2300 | 05:52:18 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:18 INFO - PID 2300 | RSS: Main: 291639296 05:52:18 INFO - PID 2300 | 05:52:21 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56077/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:22 INFO - PID 2300 | RSS: Main: 354746368 05:52:22 INFO - PID 2300 | 05:52:25 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56077/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:25 INFO - PID 2300 | RSS: Main: 371347456 05:52:25 INFO - PID 2300 | 05:52:28 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56077/tests/kraken/driver.html?testName=json-parse-financial) 05:52:29 INFO - PID 2300 | RSS: Main: 378261504 05:52:29 INFO - PID 2300 | 05:52:30 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:31 INFO - PID 2300 | RSS: Main: 332300288 05:52:31 INFO - PID 2300 | 05:52:33 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:33 INFO - PID 2300 | RSS: Main: 334864384 05:52:33 INFO - PID 2300 | 05:52:35 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:36 INFO - PID 2300 | RSS: Main: 337149952 05:52:36 INFO - PID 2300 | 05:52:39 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:40 INFO - PID 2300 | RSS: Main: 345333760 05:52:40 INFO - PID 2300 | 05:52:43 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:44 INFO - PID 2300 | RSS: Main: 343085056 05:52:44 INFO - PID 2300 | 05:52:45 INFO - PID 2300 | Cycle 1(1): loaded http://localhost:56077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56077/tests/kraken/driver.html?testName=ai-astar) 05:52:46 INFO - PID 2300 | RSS: Main: 385843200 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | __start_tp_report 05:52:46 INFO - PID 2300 | _x_x_mozilla_page_load 05:52:46 INFO - PID 2300 | _x_x_mozilla_page_load_details 05:52:46 INFO - PID 2300 | |i|pagename|runs| 05:52:46 INFO - PID 2300 | |0;ai-astar;109;110;110;110;109;111;109;109;110;109 05:52:46 INFO - PID 2300 | |1;audio-beat-detection;141;109;112;176;146;109;110;106;137;107 05:52:46 INFO - PID 2300 | |2;audio-dft;189;186;184;186;188;185;185;185;183;182 05:52:46 INFO - PID 2300 | |3;audio-fft;83;60;57;86;59;62;56;61;96;85 05:52:46 INFO - PID 2300 | |4;audio-oscillator;93;71;88;69;69;69;88;69;69;89 05:52:46 INFO - PID 2300 | |5;imaging-gaussian-blur;87;86;87;86;87;86;86;87;87;86 05:52:46 INFO - PID 2300 | |6;imaging-darkroom;93;94;96;93;93;93;96;93;93;93 05:52:46 INFO - PID 2300 | |7;imaging-desaturate;84;83;85;84;84;85;87;84;86;87 05:52:46 INFO - PID 2300 | |8;json-parse-financial;48;47;46;48;47;48;50;48;49;49 05:52:46 INFO - PID 2300 | |9;json-stringify-tinderbox;54;60;59;53;65;62;57;60;60;59 05:52:46 INFO - PID 2300 | |10;stanford-crypto-aes;81;82;83;84;81;83;86;81;82;82 05:52:46 INFO - PID 2300 | |11;stanford-crypto-ccm;136;140;150;146;132;156;134;137;262;161 05:52:46 INFO - PID 2300 | |12;stanford-crypto-pbkdf2;187;189;170;182;228;239;184;187;222;183 05:52:46 INFO - PID 2300 | |13;stanford-crypto-sha256-iterative;61;91;96;66;69;68;68;68;69;74 05:52:46 INFO - PID 2300 | __end_tp_report 05:52:46 INFO - PID 2300 | __start_cc_report 05:52:46 INFO - PID 2300 | _x_x_mozilla_cycle_collect,2191 05:52:46 INFO - PID 2300 | __end_cc_report 05:52:46 INFO - PID 2300 | __startTimestamp1493729566121__endTimestamp 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | ------- Summary: start ------- 05:52:46 INFO - PID 2300 | Number of tests: 14 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:52:46 INFO - PID 2300 | Values: 109.0 110.0 110.0 110.0 109.0 111.0 109.0 109.0 110.0 109.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:124.50 stddev:23.65 (19.0%) stddev-sans-first:24.39 05:52:46 INFO - PID 2300 | Values: 141.0 109.0 112.0 176.0 146.0 109.0 110.0 106.0 137.0 107.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.50 stddev:2.11 (1.1%) stddev-sans-first:1.76 05:52:46 INFO - PID 2300 | Values: 189.0 186.0 184.0 186.0 188.0 185.0 185.0 185.0 183.0 182.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#3] audio-fft Cycles:10 Average:70.50 Median:72.50 stddev:15.11 (20.8%) stddev-sans-first:15.33 05:52:46 INFO - PID 2300 | Values: 83.0 60.0 57.0 86.0 59.0 62.0 56.0 61.0 96.0 85.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.50 stddev:10.52 (13.2%) stddev-sans-first:9.53 05:52:46 INFO - PID 2300 | Values: 93.0 71.0 88.0 69.0 69.0 69.0 88.0 69.0 69.0 89.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:52:46 INFO - PID 2300 | Values: 87.0 86.0 87.0 86.0 87.0 86.0 86.0 87.0 87.0 86.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:93.00 stddev:1.25 (1.3%) stddev-sans-first:1.30 05:52:46 INFO - PID 2300 | Values: 93.0 94.0 96.0 93.0 93.0 93.0 96.0 93.0 93.0 93.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.37 (1.6%) stddev-sans-first:1.41 05:52:46 INFO - PID 2300 | Values: 84.0 83.0 85.0 84.0 84.0 85.0 87.0 84.0 86.0 87.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:1.15 (2.4%) stddev-sans-first:1.22 05:52:46 INFO - PID 2300 | Values: 48.0 47.0 46.0 48.0 47.0 48.0 50.0 48.0 49.0 49.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:60.00 stddev:3.54 (5.9%) stddev-sans-first:3.28 05:52:46 INFO - PID 2300 | Values: 54.0 60.0 59.0 53.0 65.0 62.0 57.0 60.0 60.0 59.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.58 (1.9%) stddev-sans-first:1.58 05:52:46 INFO - PID 2300 | Values: 81.0 82.0 83.0 84.0 81.0 83.0 86.0 81.0 82.0 82.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:148.00 stddev:38.69 (26.1%) stddev-sans-first:40.39 05:52:46 INFO - PID 2300 | Values: 136.0 140.0 150.0 146.0 132.0 156.0 134.0 137.0 262.0 161.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.10 Median:188.00 stddev:23.41 (12.5%) stddev-sans-first:24.54 05:52:46 INFO - PID 2300 | Values: 187.0 189.0 170.0 182.0 228.0 239.0 184.0 187.0 222.0 183.0 05:52:46 INFO - PID 2300 | 05:52:46 INFO - PID 2300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:69.00 stddev:11.32 (16.4%) stddev-sans-first:11.15 05:52:46 INFO - PID 2300 | Values: 61.0 91.0 96.0 66.0 69.0 68.0 68.0 68.0 69.0 74.0 05:52:46 INFO - PID 2300 | -------- Summary: end -------- 05:52:46 INFO - PID 2300 | 05:52:47 INFO - TEST-INFO | 2300: exit 0 05:52:47 INFO - TEST-OK | kraken | took 59955ms 05:52:47 INFO - SUITE-END | took 1178s 05:52:47 INFO - Completed test suite (00:19:38) 05:52:47 INFO - javascript benchmark 05:52:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.609120707437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3504.5268888700016, 3532.604621174636, 3568.8929332120038, 3572.1605422725656, 3581.194231297958, 5996.670183139926, 6111.938880611193, 6267.968660156698, 6271.560990730651, 6276.6547839868845, 6048.2137322148055, 6061.939380606193, 6070.271567411905, 6088.512918966483, 6106.755729770815, 5196.246544251081, 5236.2931004314405, 5239.711815850127, 5256.5794736421185, 5316.6544174628525, 5373.319276295731, 5377.193420986844, 5381.650192737459, 5385.138377859544, 5388.892222155555, 5351.384590772072, 5352.4915133062295, 5356.785728570852, 5370.812021579245, 5373.435789242132, 5336.573074154097, 5340.893182136336, 5344.038073146832, 5347.224652425396, 5361.088614935451, 5220.582353411718, 5273.2617433559335, 5305.814296499642, 5343.599230057723, 5363.651362661414, 6204.751809927598, 6208.596441231305, 6244.937550624481, 6246.156768836195, 6247.656378899159, 6327.5570710050315, 6441.291457939623, 6450.548461607689, 6460.095586617877, 6494.220693516761, 6033.456988871023, 6448.355164483561, 6463.450606698436, 6482.870342593122, 6516.2506311773805, 5240.6069544784295, 6362.522810789209, 6365.458935990493, 6384.425401713868, 6398.936010639927, 6766.391024807693, 6771.0, 6772.051912732221, 6774.322567743285, 6784.185897692309, 6078.665673388006, 6106.572539922252, 6343.397377249154, 6438.6136831790245, 6451.064595633607, 6443.226812782403, 6475.158229430144, 6522.184726909137, 6555.344465553407, 6614.801555953329, 6434.774782882577, 6452.1289625900845, 6456.677166141674, 6467.773627923, 6472.352764723584, 6416.807495775134, 6443.452306553995, 6463.15978922737, 6488.772892948724, 6495.0, 5078.3905931287745, 5135.229715542699, 5253.106971814801, 5258.447862974333, 5267.868303292448, 4684.1334353144775, 4686.203345431285, 4693.95306046942, 4712.0, 4731.7634118293945, 6227.221597300338, 6237.812865614039, 6246.531510136758, 6253.937460625336, 6254.718537665816, 6329.588576742497, 6434.195725534309, 6462.450691691165, 6492.967535162294, 6599.60402375859, 6165.352637973038, 6173.722182501709, 6215.34738852423, 6220.720067596969, 6221.191245138103, 5712.143178523172, 5712.885742285131, 5733.455321744427, 5746.88506229873, 5770.451807078321, 6564.770233041821, 6597.505187111082, 6714.160729908762, 6794.72821087151, 6800.047993280846, 5824.592278540462, 6579.835504112435, 6610.933890661032, 6627.966860165669, 6636.236832764101, 6760.526763126534, 6806.18325800907, 6816.0457535944015, 6826.419754320938, 6842.692078856563, 4986.276989836526, 6329.208848893888, 6429.164208653032, 6449.774257900951, 6522.021696745336, 6555.6066636002, 6558.80323590293, 6594.736210551524, 6600.570962887397, 6618.70215840298, 6414.102025716496, 6421.325760795049, 6430.485561155003, 6439.613623182624, 6456.870862582628, 6251.281102673069, 6311.652859092794, 6332.366763323631, 6333.746650133943, 6416.839579010375, 6259.311475737574, 6280.183576135073, 6305.905411418924, 6309.400606942333, 6316.715747791269, 6387.265464471645, 6404.615723056631, 6419.935800642121, 6443.9355606445215, 6452.387023232785, 6304.5271604628915, 6354.046892965907, 6360.332165122595, 6364.93635063662, 6369.9681501592195], "value": 5991.672738665819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.6407134753688, 802.7471346525844, 1117.4133579870568, 1132.4507613807298, 1144.7653231087634, 32353.0, 35465.468017979685, 35518.75684351045, 35715.0, 35750.0, 37516.43725344122, 37521.0, 37545.62454375455, 37603.3594960756, 37667.24665506688, 5802.419758024185, 8112.999999999985, 8229.0, 8241.340692744567, 8248.010238771356, 5809.506191973687, 8076.071251806059, 8199.549024803633, 8223.917760822405, 8236.876446853303, 7029.683664235096, 8305.626246818907, 8310.667573297062, 8323.209295116954, 8346.165383461666, 5873.618214816023, 8240.958795206016, 8280.627371768254, 8285.42002059856, 8318.875216871751, 5827.941720582782, 7889.447738658297, 7995.000624921885, 8009.719659811879, 8027.2775450209765, 35656.0, 35969.280614387826, 36014.27971440583, 36014.81992590046, 36212.09469763277, 3526.0, 3554.36021516127, 3564.287142571496, 3564.8752293669854, 3568.3220188164164, 29580.0, 29629.11112666602, 29660.0, 29754.80980760767, 29775.808967641267, 3094.102710214058, 3134.3104517006223, 3159.605049368829, 3174.1747145742042, 3180.5865237519206, 256929.0, 295932.0, 296564.0, 297007.0, 300199.0, 38001.80999095042, 38583.61416385856, 47358.052838943026, 47501.76249118732, 47685.76157119262, 40648.0, 48757.756211218715, 49272.0, 49301.0, 49342.75328623406, 12226.510939562495, 13542.0, 13657.248851313274, 13662.863371366358, 13678.452861885413, 10582.259241852997, 11146.944265278622, 11164.162687798447, 11170.994610485095, 11197.272177308449, 12509.249445033327, 12521.74956500865, 12567.18313309632, 12572.119951603483, 12672.49310027607, 5161.845144645667, 5207.479252074838, 5208.5051920067535, 5208.609354298443, 5217.791288348423, 972.863799068131, 1008.4201584089178, 1018.4856647393167, 1057.6086847866338, 1060.1730650092786, 22820.201292954665, 23993.760062399153, 24123.638145427834, 24132.091447925348, 24367.26898193057, 961.6105477281712, 1000.3747657713928, 1107.191750022472, 1114.1365441782684, 1128.2835399521364, 9182.908170918205, 11647.41762911851, 12145.271283723005, 12208.023358131328, 12227.938860305641, 297314.0, 299527.0, 300411.49794251326, 301754.9649007008, 301757.49121254694, 51228.48771512312, 51422.0, 51425.7428712854, 51434.228486572734, 51545.48454515482, 1465.4577806211769, 1481.8518148185094, 1481.977770333446, 1529.350026238844, 1530.1584128729155, 23414.765852341257, 23494.412639684146, 23529.882350588137, 23577.056917723097, 23697.0, 29706.851465742533, 31059.37881242408, 37730.811345944196, 37838.24323513459, 37983.62016379911, 282532.0, 284098.0, 284161.0, 284200.15799842565, 284728.0, 29262.853685731436, 29957.400851982402, 33316.83341583276, 33757.3248535023, 33920.25116483645, 40907.0, 42438.57561424346, 42499.362509563, 42505.78747106368, 42634.360484592136, 28050.877964881176, 28778.568321474777, 29007.274818129714, 29823.403531929675, 29967.951121710634, 26077.478450430506, 29450.0, 29623.555646665747, 29728.702712972594, 29929.401411972074, 34373.0, 34465.655343447244, 35081.473777893865, 35889.0, 35897.64102358943, 29165.416691665625, 29430.558541622322, 29902.252443688212, 29958.35372369706, 30063.947761829106, 17218.741718874477, 23047.769522304563, 23366.94848731777, 23383.298501044996, 23629.88185059064], "value": 16722.004959228892, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5810880324422, 422.0338009837885, 433.43220381300506, 434.73046711039154, 452.45253243575274, 19298.90350548247, 20758.0, 21236.68144977823, 21481.03335349909, 21512.56974860502, 21814.563708725815, 22663.433414164654, 23231.883840580816, 23372.76627233727, 23417.882910585467, 6039.486643635296, 6276.748930042792, 6289.308176100625, 6305.369463053681, 6306.306306306303, 5881.206037184989, 6108.236470441195, 6153.077038444225, 6170.7223174957235, 6185.690715464231, 5896.439838215363, 6105.908411373833, 6120.69396530174, 6124.663143527104, 6128.96935515324, 6032.396760323976, 6165.0, 6177.166082578839, 6179.907301390483, 6189.319174890758, 5284.365876094893, 5422.9728851355885, 5498.3127109111365, 5517.089680202762, 5528.530074943635, 26933.865330673416, 27089.458210835674, 27294.5905811413, 27945.0, 27975.58036629452, 2144.345974477784, 2163.3618082665653, 2189.27753841232, 2217.866927984326, 2230.631945728953, 17218.31126754928, 17251.913740431217, 17927.551811204823, 18218.45344639663, 18389.356372526898, 1742.35532852844, 2141.250562303197, 2183.115838085562, 2183.585118827418, 2189.1243502598927, 140597.2970135153, 141434.0, 143417.0, 143884.0, 144385.99999999895, 11790.705232369259, 12225.742930539775, 12299.93850030744, 12336.62990110298, 12384.75230495385, 16284.837151628331, 16333.183340832911, 16368.83631163697, 16384.344626215057, 16418.83581164173, 8621.482711037232, 8752.905886764154, 8864.335174861912, 8936.731898042939, 8997.955010224907, 7052.753153639598, 7164.964175179195, 8320.500769953822, 8381.580920953927, 8462.576871156542, 7629.465937384441, 7680.846383072419, 7717.614119294013, 7832.451728378959, 7839.921600784033, 2125.4155107345296, 2129.7444306683296, 2130.850840441154, 2140.486283291999, 2309.1686992682958, 898.4250079948838, 912.4570880326195, 921.6543796076471, 968.6222373274429, 969.6606187834202, 20819.58360832775, 20865.0, 20890.686639700416, 20896.268630597857, 21008.684869726967, 818.2676504528414, 954.2517549457518, 978.9021097890154, 988.683621241196, 990.2372381056915, 7920.960395197987, 10906.127509799197, 13268.93365533166, 13820.585382438543, 14089.09797177368, 551913.0, 557878.0, 562266.0, 562927.0, 564466.0, 101264.49367753262, 123085.92168213762, 123122.15316770256, 127543.0, 132275.0, 1166.2477701882237, 1169.3101070368523, 1212.799888018467, 1217.8538575371012, 1220.3593113615423, 17787.73318400199, 21399.0, 22336.888315558317, 22407.887960560092, 22586.435339115997, 45684.77157614191, 57306.0, 57717.0, 57910.7104464475, 58120.2563923083, 75885.62057189678, 77599.07610624624, 79491.60254198693, 81392.77910831224, 81841.77237341563, 8772.078931712078, 8835.71882077108, 8839.248663863644, 9182.632694692138, 9363.204127649225, 14599.562013139623, 14759.704805904037, 14916.627084322545, 15027.398904044154, 15164.165970871709, 11258.943705281748, 12152.513899443924, 12211.633650990485, 12216.572419965258, 12282.201656892274, 10242.334248273839, 10498.317609355367, 11470.369129697612, 11780.646580602595, 11788.705282367666, 12328.81506777417, 12340.629781106582, 12495.93752031234, 12679.23924564529, 12780.169288996558, 8158.3473322132895, 9043.32175086858, 9067.773305667411, 9093.090690930854, 9355.532223388667, 12109.69725756863, 12127.696807579881, 12382.504699811907, 12422.751544969231, 12456.377181141088], "value": 10448.931880924945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.591315995982, 1217.896478799302, 1407.6691977385312, 1421.3319739722326, 1423.4590855474914, 9574.904250957488, 9713.514324283775, 11013.669589912306, 11687.766244675102, 11700.707482312957, 11297.774044519105, 11395.259308144965, 11397.202195846294, 11419.200655954066, 11463.942680286587, 2081.188336548747, 2393.617021276596, 2436.6954130733657, 2438.2807071913826, 2440.6217036359394, 2149.4196566927, 2417.2627348658652, 2524.5960646296594, 2542.2373288013614, 2542.377117606189, 2439.6828412306377, 2463.6427717980882, 2488.079410618074, 2489.0914816092177, 2489.128804918273, 2456.570100232452, 2465.285067330472, 2488.365466805953, 2488.713797913236, 2495.9750402495924, 2452.2398056602333, 2455.2020593307248, 2460.4463995601027, 2461.655368248447, 2461.9876900615563, 11007.779844403147, 11103.72240693981, 11116.722081947935, 11118.22172447929, 11127.998480136746, 5244.554212891909, 6430.646314452703, 6512.0, 6518.152640156797, 6520.902186467207, 3805.809709514541, 4040.939385909214, 4173.624373806341, 4193.0, 4203.726757760766, 1252.3863306979606, 1253.9749205015848, 1286.4468278640181, 1298.2340419152745, 1303.172485471723, 15514.5345639631, 15880.444184453489, 15881.761773573406, 15907.0455772654, 15907.840921590752, 4581.816727330936, 5146.408163061295, 5622.297212848394, 5662.631928924607, 5902.76388944446, 13151.539696110782, 13152.802707959388, 13176.47294108244, 13180.736385272241, 13181.143225690299, 6459.321771214049, 6581.539292249592, 6599.274079851212, 6608.2730899601, 6611.140551728245, 5829.213056237354, 6091.329953705089, 6096.634201947897, 6133.3866613338305, 6236.314005459396, 3702.500162478031, 4198.097409057067, 4310.0, 4339.3924850520325, 4340.891477713082, 1258.7545428641326, 1260.0738457233927, 1270.4664041102758, 1276.0812215205037, 1278.1947373154853, 792.6750032486652, 811.6144831205248, 824.826786374868, 828.353883970504, 854.0, 4695.85912422621, 6012.428819262163, 6014.909776353358, 6047.848803779941, 6315.421144713821, 586.7418335932176, 602.193061297863, 608.8051823416553, 610.6763415389851, 611.9510439164856, 3329.0012996101073, 4300.591443812833, 4310.956890431118, 4373.2128216921255, 4494.348319493655, 14206.644833879029, 14330.856691432953, 14450.205238711971, 14715.852841471662, 14732.337044833008, 14074.577762667137, 14660.706785864222, 14665.266736663338, 14670.926645366919, 14678.972471927076, 8163.224493673091, 8451.915480845235, 8548.358873084419, 8558.871616925751, 8569.78575535604, 5233.555147812479, 6844.178698556205, 6999.755008574675, 7030.753923612649, 7035.401990830836, 12851.421686023965, 12890.226586404846, 12932.870671293167, 13044.086913915935, 13246.933765331112, 10982.890171098506, 12252.75494490123, 13532.188068715908, 13548.661283467993, 13576.253306068262, 6643.534952553468, 8253.752387428387, 9215.2627789778, 9219.03200163973, 9231.123043310874, 10292.742681433025, 10429.061384475433, 10466.215033872642, 10471.214658900766, 10568.20738444635, 8726.956365218133, 8868.467891926504, 8915.465072095694, 8925.196732293865, 9081.68214112503, 8592.570371481275, 8725.607347669496, 8799.956000219958, 8829.911700882909, 8833.867491987754, 7978.84042319162, 8119.634616442392, 8139.104698483044, 8139.715109971123, 8141.0230772307705, 5837.562182836219, 5871.794487192928, 6002.789902353396, 6081.239845019372, 6108.5723999319625, 5518.227448157341, 5936.347001829881, 6142.723577438936, 6148.354422785543, 6152.908011276188], "value": 5194.858856312093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.9782211978341, 398.2453251089186, 403.65487508180513, 405.29883301887713, 410.8028146489683, 5144.17693169093, 5434.483724046214, 5793.768249270024, 5824.213731146294, 5851.561132915027, 5488.890222195564, 5575.442455754423, 5617.606767526275, 5673.546116310696, 5729.0, 4357.978210108961, 4370.912581748363, 4383.167198232326, 4396.428464299636, 4403.367222041828, 4396.164728701552, 4396.230659634567, 4396.406485124499, 4416.536263692315, 4428.40216570762, 3576.92846143077, 3805.82873770681, 4310.159518893817, 4341.891452713691, 4383.978080109595, 4329.891752706176, 4338.43600331958, 4344.261475549164, 4356.673249506284, 4358.694891357606, 3874.9731321199906, 3889.747166434173, 3919.804009799527, 3934.350832112698, 3935.1736135411597, 4632.606228470584, 5457.962987032491, 5506.366767821712, 5606.775728970836, 5643.435656434365, 5203.089459344599, 5270.417495427251, 5275.072334854154, 5301.125314323132, 5304.549113325372, 6138.386161383871, 6153.7230824613, 6178.41305076017, 6203.96898015507, 6206.627602343874, 3851.7496362736333, 4066.837326506966, 4083.203775263825, 4096.938545921784, 4112.383142528614, 5558.832645144484, 5561.666300021971, 6232.345603711636, 6385.904211436832, 6489.740410383579, 4007.1785284016705, 4016.116454380032, 4117.032497363117, 4124.52567954683, 4133.46264985556, 3982.4424580558743, 4181.686373521937, 4189.72766770159, 4193.6645068394455, 4217.557156498524, 4264.552222016706, 4718.811247550128, 4776.402949631296, 4858.076965376567, 4878.682885612424, 5045.520675535819, 6081.391860813883, 6089.985457198626, 6090.512758979271, 6151.077338399186, 1367.459853357918, 1403.7473254814026, 1417.5038736442164, 1424.4871846135384, 1425.9001869869217, 906.2976193450129, 935.8175155844544, 938.9295802814817, 943.5140902435252, 950.7623094226443, 5787.668836167621, 5804.8653726987795, 5838.416158384212, 5857.301382598998, 5862.299933019462, 5320.946790532123, 5985.760569577255, 6237.500999919996, 6264.1856558648, 6336.398042185985, 4880.389951256093, 4888.60891128716, 5320.521153096162, 5550.363577300831, 5734.853029394138, 2711.928788128678, 2808.803383763117, 3106.7980581262145, 3277.2789986202997, 3299.191698033997, 6320.778772742932, 6367.61794292344, 6454.612723236621, 6483.286838447767, 6498.54510184292, 6451.516136289797, 6463.385978332051, 6465.450436712932, 6503.154589903283, 6519.641419721961, 6193.345925903738, 6391.392817682313, 6417.358264173546, 6499.935000649933, 6554.147960765165, 5320.701165277553, 6255.499560035278, 6298.622082675054, 6299.275583307978, 6373.948298530876, 4929.457759646508, 5182.352205974254, 5711.543076553782, 6229.345918678474, 6236.688165591793, 6186.659733714509, 6348.587341822767, 6494.480441564758, 6503.512236582181, 6517.902231466626, 3746.875937218878, 3860.613938606117, 4076.2662720709372, 4108.835646574224, 4112.979435102805, 5046.914913293659, 5778.479936805707, 5837.124431335334, 6318.589291696025, 6330.778422755181, 5078.949210507995, 5128.384488935366, 6104.4505994460715, 6118.479929206067, 6145.354737752472, 5840.503557197686, 6038.909416358671, 6068.453839154321, 6120.632762034292, 6142.170806941006, 5796.82609521715, 5973.790917317873, 6003.879922401615, 6026.849328766816, 6040.75836966534, 4828.444728856086, 5886.38192989747, 6136.386361363828, 6160.537959652955, 6178.876422471615, 4597.586217240464, 5697.772089116389, 5713.914551095986, 5906.557008224487, 5964.522838173022], "value": 4458.5490949075265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6335087429977, 861.3109512390087, 867.1631875240396, 871.0070519607648, 881.5195718333507, 13024.0, 18311.267549298027, 18395.72406413905, 18655.626887462244, 18831.340903068394, 16790.244439000242, 18019.549511262227, 18422.26310947564, 18453.907730461364, 18588.34940777073, 956.9856452153241, 979.4123525884448, 983.7393090830935, 984.1388784813288, 988.5205675247499, 686.8591938652564, 706.8974998625197, 828.2918105020211, 993.5975929748428, 1016.2479764973903, 1024.8462730590397, 1026.8305729554652, 1027.0499787696351, 1029.0584115534277, 1061.8460323253123, 1026.3841694983025, 1026.4457193115784, 1033.0650761061213, 1033.3593172233263, 1073.624231518966, 749.8050506868199, 758.5751978891839, 762.3253420722644, 769.6805825582377, 798.1380109481746, 16752.078635675032, 16941.407050753165, 17103.23035463407, 17461.03964281964, 17638.911805441017, 16920.830791692173, 16974.15129243533, 17443.30226790927, 17446.56383590408, 17512.949223046657, 13835.0, 13864.237466939314, 13981.0, 14215.928920355436, 14227.715445691028, 3460.619331873492, 3495.2834668892815, 3495.5106285120105, 3496.667816557423, 3496.667816557423, 130020.34989825085, 130213.0, 131845.34077329648, 131950.3609927796, 132542.0, 11020.118390528738, 11341.149413793999, 13163.53927612548, 13241.205527668371, 13243.470261189637, 19596.608067838562, 25020.749792502207, 25392.365190870005, 25602.103926362488, 25782.226533204033, 7764.805879853049, 7885.329746971572, 7941.444098913021, 7946.086200086948, 7950.324222441157, 3910.4329872168946, 3955.940660890089, 4002.459667944848, 4006.3790112532606, 4014.1770936957855, 4173.9582604174175, 4241.088166044254, 4255.1915136124035, 4269.829206831692, 4270.807813648331, 929.8977112517617, 934.4019827310391, 943.8537026760863, 948.137195152408, 949.5916755794937, 652.6182183422655, 667.89981502774, 683.2757277286092, 687.2131409536054, 704.7568588836843, 11073.169512286611, 11342.659720208407, 11372.14708896836, 11830.940845295718, 11859.762804743857, 656.5305806348483, 661.0777964739162, 670.7201783279766, 672.3343889549311, 678.7352932356386, 5472.616916815785, 5967.701614919323, 6027.6986150693165, 6031.155638210654, 6068.757249709962, 90585.0, 91247.81932787817, 105482.0, 107900.46049769857, 108061.45969270103, 92221.0, 92929.53535232281, 94593.0540694598, 94939.52530237305, 94987.52506237425, 83286.0, 83317.16682833215, 85720.57139714262, 85980.57009714912, 86411.0, 12099.395030248628, 12413.44139513706, 12461.875381246435, 12488.812667810173, 12515.186512876633, 34318.31363372769, 40975.59024409837, 41906.0, 42031.0, 42230.0, 37918.81040594779, 47908.0, 54420.0, 54483.72758136184, 55099.44900550943, 16394.508164755076, 17018.404355847983, 17239.310427582757, 17334.04662743561, 17343.132843358035, 17764.55588610295, 18086.90956545209, 18105.185266662767, 18670.43988680342, 18738.531536711693, 16503.422380217115, 17028.574285642957, 17352.91323543374, 17633.64732705313, 17695.46913592594, 16870.409535666193, 17200.741988869926, 17386.826131738522, 17656.20547075359, 17818.10909454548, 16462.917685411496, 17262.913685431493, 17270.913645431694, 17367.392141274995, 17440.953542787473, 11719.648410547697, 11791.35147566892, 12102.0, 12221.511139554319, 12466.439010244741, 13026.0, 13494.865051349361, 14137.646558836112, 14182.574522764333, 14240.572782816533], "value": 8432.734637230704, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 109.0, 110.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 112.0, 176.0, 146.0, 109.0, 110.0, 106.0, 137.0, 107.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 186.0, 184.0, 186.0, 188.0, 185.0, 185.0, 185.0, 183.0, 182.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 57.0, 86.0, 59.0, 62.0, 56.0, 61.0, 96.0, 85.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 88.0, 69.0, 69.0, 69.0, 88.0, 69.0, 69.0, 89.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 86.0, 87.0, 87.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 96.0, 93.0, 93.0, 93.0, 96.0, 93.0, 93.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 84.0, 84.0, 85.0, 87.0, 84.0, 86.0, 87.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 46.0, 48.0, 47.0, 48.0, 50.0, 48.0, 49.0, 49.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 59.0, 53.0, 65.0, 62.0, 57.0, 60.0, 60.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 83.0, 84.0, 81.0, 83.0, 86.0, 81.0, 82.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 150.0, 146.0, 132.0, 156.0, 134.0, 137.0, 262.0, 161.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 170.0, 182.0, 228.0, 239.0, 184.0, 187.0, 222.0, 183.0], "value": 197.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 91.0, 96.0, 66.0, 69.0, 68.0, 68.0, 68.0, 69.0, 74.0], "value": 73.0, "unit": "score"}]}]} 05:52:47 INFO - Return code: 0 05:52:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:47 ERROR - # TBPL SUCCESS # 05:52:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:47 INFO - 2017-05-02 05:52:47.418 screenresolution[2310:20342] starting screenresolution argv=screenresolution get 05:52:47 INFO - 2017-05-02 05:52:47.420 screenresolution[2310:20342] Display 0: 1600x1200x32@60 05:52:47 INFO - 2017-05-02 05:52:47.427 screenresolution[2311:20345] starting screenresolution argv=screenresolution list 05:52:47 INFO - Available Modes on Display 0 05:52:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:47 INFO - Intel Iris: 05:52:47 INFO - Chipset Model: Intel Iris 05:52:47 INFO - Type: GPU 05:52:47 INFO - Bus: Built-In 05:52:47 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:47 INFO - Vendor: Intel (0x8086) 05:52:47 INFO - Device ID: 0x0a2e 05:52:47 INFO - Revision ID: 0x0009 05:52:47 INFO - Displays: 05:52:47 INFO - Display: 05:52:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:47 INFO - Display Serial Number: 1600x1200 60 05:52:47 INFO - Main Display: Yes 05:52:47 INFO - Mirror: Off 05:52:47 INFO - Online: Yes 05:52:47 INFO - Rotation: Supported 05:52:47 INFO - Return code: 0 05:52:47 INFO - Running post-action listener: _resource_record_post_action 05:52:47 INFO - [mozharness: 2017-05-02 12:52:47.672442Z] Finished run-tests step (success) 05:52:47 INFO - Running post-run listener: _resource_record_post_run 05:52:47 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 159744; Write bytes: 514961408; Read time: 4; Write time: 1593 05:52:47 INFO - TinderboxPrint: CPU usage
53.5% 05:52:47 INFO - TinderboxPrint: I/O read bytes / time
159,744 / 4 05:52:47 INFO - TinderboxPrint: I/O write bytes / time
514,961,408 / 1,593 05:52:47 INFO - TinderboxPrint: CPU idle
2,230.4 (46.5%) 05:52:47 INFO - TinderboxPrint: CPU system
959.0 (20.0%) 05:52:47 INFO - TinderboxPrint: CPU user
1,608.1 (33.5%) 05:52:47 INFO - TinderboxPrint: Swap in / out
208,199,680 / 0 05:52:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209439232; Write bytes: 213252096; Read time: 16059; Write time: 463 05:52:47 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 73728; Write bytes: 300333056; Read time: 3; Write time: 1120 05:52:48 INFO - Running post-run listener: _upload_blobber_files 05:52:48 INFO - Blob upload gear active. 05:52:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:48 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 05:52:48 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:48 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:49 INFO - (blobuploader) - INFO - Done attempting. 05:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:50 INFO - (blobuploader) - INFO - Done attempting. 05:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:51 INFO - (blobuploader) - INFO - Done attempting. 05:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:54 INFO - (blobuploader) - INFO - Done attempting. 05:52:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:54 INFO - Return code: 0 05:52:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561f8149bacd6a416dcd2cce58568049eb51b7191874b23965b240390cb1ff417f0c0926829b09f7a8bf38e8dc3417ed185fc53bbe07506ec713182598f6afbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7910868c51d718c5d862f5f61290eae0fd8ed746fc088aa190494d2b178a9db8f78ba5aac323ef07040267bbd88edb355fbe893ea839ba9ace661f0aa515a12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7e4cf1bb700cac278fbd9b61818ba8357ec05e0016e3cbad09e3d9cb19ea1df962eea4bd95e9765b8d9643966f6e08d6c59901b2e75fb2bc2f3252b5dbad76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0131f5b676bd7e7a4224ee1a3039a23ed4f60f603d298bdebcdd38dd5bbf2395462cbc1c1b907a65c645d624bdd3f7e7f1dfc72b7145335a1037f9f663cde7d3"} 05:52:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:54 INFO - Contents: 05:52:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561f8149bacd6a416dcd2cce58568049eb51b7191874b23965b240390cb1ff417f0c0926829b09f7a8bf38e8dc3417ed185fc53bbe07506ec713182598f6afbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7910868c51d718c5d862f5f61290eae0fd8ed746fc088aa190494d2b178a9db8f78ba5aac323ef07040267bbd88edb355fbe893ea839ba9ace661f0aa515a12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7e4cf1bb700cac278fbd9b61818ba8357ec05e0016e3cbad09e3d9cb19ea1df962eea4bd95e9765b8d9643966f6e08d6c59901b2e75fb2bc2f3252b5dbad76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0131f5b676bd7e7a4224ee1a3039a23ed4f60f603d298bdebcdd38dd5bbf2395462cbc1c1b907a65c645d624bdd3f7e7f1dfc72b7145335a1037f9f663cde7d3"} 05:52:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:54 INFO - Copying logs to upload dir... 05:52:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.471905 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-02 05:52:54.515674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:54.523508) ========= 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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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/Firefox/sha512/561f8149bacd6a416dcd2cce58568049eb51b7191874b23965b240390cb1ff417f0c0926829b09f7a8bf38e8dc3417ed185fc53bbe07506ec713182598f6afbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7910868c51d718c5d862f5f61290eae0fd8ed746fc088aa190494d2b178a9db8f78ba5aac323ef07040267bbd88edb355fbe893ea839ba9ace661f0aa515a12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7e4cf1bb700cac278fbd9b61818ba8357ec05e0016e3cbad09e3d9cb19ea1df962eea4bd95e9765b8d9643966f6e08d6c59901b2e75fb2bc2f3252b5dbad76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0131f5b676bd7e7a4224ee1a3039a23ed4f60f603d298bdebcdd38dd5bbf2395462cbc1c1b907a65c645d624bdd3f7e7f1dfc72b7145335a1037f9f663cde7d3"} build_url:https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/eEFQ4bAwSnajyIPO_-E59A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561f8149bacd6a416dcd2cce58568049eb51b7191874b23965b240390cb1ff417f0c0926829b09f7a8bf38e8dc3417ed185fc53bbe07506ec713182598f6afbb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7910868c51d718c5d862f5f61290eae0fd8ed746fc088aa190494d2b178a9db8f78ba5aac323ef07040267bbd88edb355fbe893ea839ba9ace661f0aa515a12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7e4cf1bb700cac278fbd9b61818ba8357ec05e0016e3cbad09e3d9cb19ea1df962eea4bd95e9765b8d9643966f6e08d6c59901b2e75fb2bc2f3252b5dbad76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0131f5b676bd7e7a4224ee1a3039a23ed4f60f603d298bdebcdd38dd5bbf2395462cbc1c1b907a65c645d624bdd3f7e7f1dfc72b7145335a1037f9f663cde7d3"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:54.924087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:54.924801) ========= 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.u1N5qE6cc7/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.f7wJoBkGZH/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005264 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 05:52:54.963128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 05:52:54.963473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 05:52:54.963828) ========= ========= Total master_lag: 0.61 =========