builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0133 starttime: 1487003425.68 results: success (0) buildid: 20170213053639 builduid: 6a3a688ab40e4ccba504016970236cc4 revision: f984c74df66ca1fce52d414fe9cba21b16298fe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.682901) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.683405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.683698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.715343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.715733) ========= 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.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-13 08:30:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.13M=0.001s 2017-02-13 08:30:25 (9.13 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.914971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.915304) ========= 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.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.020326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:25.967224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 08:30:25.970723) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f984c74df66ca1fce52d414fe9cba21b16298fe4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f984c74df66ca1fce52d414fe9cba21b16298fe4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-13 08:30:26,038 truncating revision to first 12 chars 2017-02-13 08:30:26,038 Setting DEBUG logging. 2017-02-13 08:30:26,038 attempt 1/10 2017-02-13 08:30:26,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f984c74df66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 08:30:27,895 unpacking tar archive at: mozilla-beta-f984c74df66c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.118844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-13 08:30:28.113202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:28.116607) ========= script_repo_revision: f984c74df66ca1fce52d414fe9cba21b16298fe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:28.117050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:28.117311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:30:28.137145) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-13 08:30:28.137594) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:30:28 INFO - MultiFileLogger online at 20170213 08:30:28 in /builds/slave/test 08:30:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:30:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:28 INFO - {'append_to_log': False, 08:30:28 INFO - 'base_work_dir': '/builds/slave/test', 08:30:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:30:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:28 INFO - 'branch': 'Mozilla-Beta', 08:30:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:28 INFO - 'config_files': ('talos/mac_config.py',), 08:30:28 INFO - 'default_actions': ('clobber', 08:30:28 INFO - 'read-buildbot-config', 08:30:28 INFO - 'download-and-extract', 08:30:28 INFO - 'populate-webroot', 08:30:28 INFO - 'create-virtualenv', 08:30:28 INFO - 'install', 08:30:28 INFO - 'run-tests'), 08:30:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:28 INFO - 'download_minidump_stackwalk': True, 08:30:28 INFO - 'download_symbols': 'ondemand', 08:30:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:28 INFO - 'installer_path': 'installer.exe', 08:30:28 INFO - 'log_level': 'info', 08:30:28 INFO - 'log_name': 'talos', 08:30:28 INFO - 'log_to_console': True, 08:30:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:30:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:30:28 INFO - 'opt_config_files': (), 08:30:28 INFO - 'pip_index': False, 08:30:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:30:28 INFO - 'cmd': ('bash', 08:30:28 INFO - '-c', 08:30:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:30:28 INFO - 'enabled': True, 08:30:28 INFO - 'halt_on_failure': False, 08:30:28 INFO - 'name': 'check_screen_resolution'},), 08:30:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:30:28 INFO - 'cmd': ('bash', 08:30:28 INFO - '-c', 08:30:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:30:28 INFO - 'enabled': True, 08:30:28 INFO - 'halt_on_failure': False, 08:30:28 INFO - 'name': 'check_screen_resolution'},), 08:30:28 INFO - 'run_cmd_checks_enabled': True, 08:30:28 INFO - 'sps_profile': False, 08:30:28 INFO - 'sps_profile_interval': 0, 08:30:28 INFO - 'suite': 'dromaeojs', 08:30:28 INFO - 'system_bits': '32', 08:30:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:28 INFO - 'title': 't-yosemite-r7-0133', 08:30:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:28 INFO - 'use_talos_json': True, 08:30:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:28 INFO - 'work_dir': 'build'} 08:30:28 INFO - [mozharness: 2017-02-13 16:30:28.328574Z] Running clobber step. 08:30:28 INFO - Running pre-action listener: _resource_record_pre_action 08:30:28 INFO - Running main action method: clobber 08:30:28 INFO - rmtree: /builds/slave/test/build 08:30:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:30 INFO - Running post-action listener: _resource_record_post_action 08:30:30 INFO - [mozharness: 2017-02-13 16:30:30.019940Z] Finished clobber step (success) 08:30:30 INFO - [mozharness: 2017-02-13 16:30:30.020066Z] Running read-buildbot-config step. 08:30:30 INFO - Running pre-action listener: _resource_record_pre_action 08:30:30 INFO - Running main action method: read_buildbot_config 08:30:30 INFO - Using buildbot properties: 08:30:30 INFO - { 08:30:30 INFO - "project": "", 08:30:30 INFO - "product": "firefox", 08:30:30 INFO - "script_repo_revision": "production", 08:30:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:30:30 INFO - "repository": "", 08:30:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:30:30 INFO - "buildid": "20170213053639", 08:30:30 INFO - "pgo_build": "False", 08:30:30 INFO - "basedir": "/builds/slave/test", 08:30:30 INFO - "buildnumber": 39, 08:30:30 INFO - "slavename": "t-yosemite-r7-0133", 08:30:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:30:30 INFO - "platform": "yosemite_r7", 08:30:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:30:30 INFO - "branch": "mozilla-beta", 08:30:30 INFO - "repo_path": "releases/mozilla-beta", 08:30:30 INFO - "revision": "f984c74df66ca1fce52d414fe9cba21b16298fe4", 08:30:30 INFO - "stage_platform": "macosx64", 08:30:30 INFO - "builduid": "6a3a688ab40e4ccba504016970236cc4", 08:30:30 INFO - "slavebuilddir": "test" 08:30:30 INFO - } 08:30:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:30:30 INFO - Running post-action listener: _resource_record_post_action 08:30:30 INFO - [mozharness: 2017-02-13 16:30:30.023352Z] Finished read-buildbot-config step (success) 08:30:30 INFO - [mozharness: 2017-02-13 16:30:30.023465Z] Running download-and-extract step. 08:30:30 INFO - Running pre-action listener: _resource_record_pre_action 08:30:30 INFO - Running main action method: download_and_extract 08:30:30 INFO - mkdir: /builds/slave/test/build/tests 08:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:30 INFO - trying https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:30:30 INFO - Downloading https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:30:31 INFO - Downloaded 1165 bytes. 08:30:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:30:31 INFO - Using the following test package requirements: 08:30:31 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:30:31 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:30:31 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:30:31 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:30:31 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:30:31 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:30:31 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:30:31 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:30:31 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:30:31 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:30:31 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:30:31 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:30:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:30:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:30:31 INFO - Fetch https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:30:31 INFO - Http code: 200 08:30:31 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 08:30:31 INFO - x-amz-cf-id: UDxcLwza_yb7Z4b4hUQ9o-I6JN3zqf9058qT3ovWqQajoNtO05T3IQ== 08:30:31 INFO - x-amz-version-id: F95uz3p7vgj9v87QjFheh8p4k0SY3Qn3 08:30:31 INFO - Expected file size: 16094123 08:30:31 INFO - Obtained file size: 16094123 08:30:38 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:30:39 INFO - Http code: 200 08:30:39 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:30:39 INFO - x-amz-cf-id: GwAcmet0GO4DOInt25LKwwsmTwoPMtRtYfFxWgsryyu0gcP6eX8okw== 08:30:39 INFO - x-amz-version-id: F95uz3p7vgj9v87QjFheh8p4k0SY3Qn3 08:30:39 INFO - Expected file size: 16094123 08:30:39 INFO - Obtained file size: 16094123 08:30:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:30:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:30:45 INFO - Fetch https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:30:46 INFO - Http code: 200 08:30:46 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:30:46 INFO - x-amz-cf-id: yqVKHnvABuvWo8N12N0_27FIQeBOdNderi0p7irVcWFec6SvrLusLQ== 08:30:46 INFO - x-amz-version-id: f3yz9XlZsCSmCBerOnKVl.ulu7IKEP6j 08:30:46 INFO - Expected file size: 14403005 08:30:46 INFO - Obtained file size: 14403005 08:30: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')]} 08:30:47 INFO - trying https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:30:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:30:49 INFO - Downloaded 82137144 bytes. 08:30:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:30:49 INFO - mkdir: /builds/slave/test/properties 08:30:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:30:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:30:49 INFO - Contents: 08:30:49 INFO - build_url:https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:30:50 INFO - Running post-action listener: _resource_record_post_action 08:30:50 INFO - Running post-action listener: set_extra_try_arguments 08:30:50 INFO - [mozharness: 2017-02-13 16:30:50.114980Z] Finished download-and-extract step (success) 08:30:50 INFO - [mozharness: 2017-02-13 16:30:50.115070Z] Running populate-webroot step. 08:30:50 INFO - Running pre-action listener: _resource_record_pre_action 08:30:50 INFO - Running main action method: populate_webroot 08:30:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:30:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:30:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:30:50 INFO - '--tppagecycles', 08:30:50 INFO - '7'], 08:30:50 INFO - 'tests': ['tsvgm']}}, 08:30:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:30:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:30:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:30:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:30:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:30:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['damp', 'tps']}, 08:30:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'tests': ['damp', 'tps']}, 08:30:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['dromaeo_dom']}, 08:30:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:30:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['basic_compositor_video']}, 08:30:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:30:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['a11yr', 08:30:50 INFO - 'ts_paint', 08:30:50 INFO - 'tpaint', 08:30:50 INFO - 'sessionrestore', 08:30:50 INFO - 'sessionrestore_no_auto_restore', 08:30:50 INFO - 'tabpaint']}, 08:30:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['tsvgx', 08:30:50 INFO - 'tsvgr_opacity', 08:30:50 INFO - 'tart', 08:30:50 INFO - 'tscrollx', 08:30:50 INFO - 'cart']}, 08:30:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:30:50 INFO - 'tsvgr_opacity', 08:30:50 INFO - 'tart', 08:30:50 INFO - 'tscrollx', 08:30:50 INFO - 'cart']}, 08:30:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'talos_options': ['--disable-e10s'], 08:30:50 INFO - 'tests': ['tp5o']}, 08:30:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'tests': ['tp5o']}, 08:30:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'talos_options': ['--disable-e10s', 08:30:50 INFO - '--xperf_path', 08:30:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:50 INFO - 'tests': ['tp5n']}, 08:30:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:30:50 INFO - 'talos_options': ['--xperf_path', 08:30:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:30:50 INFO - 'tests': ['tp5n']}}, 08:30:50 INFO - 'talos.zip': {'path': '', 08:30:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:30:50 INFO - Running post-action listener: _resource_record_post_action 08:30:50 INFO - [mozharness: 2017-02-13 16:30:50.134367Z] Finished populate-webroot step (success) 08:30:50 INFO - [mozharness: 2017-02-13 16:30:50.134479Z] Running create-virtualenv step. 08:30:50 INFO - Running pre-action listener: _resource_record_pre_action 08:30:50 INFO - Running main action method: create_virtualenv 08:30:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:30:50 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 08:30:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:30:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:30:50 INFO - Using real prefix '/tools/python27' 08:30:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:30:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:30:53 INFO - Installing pip.................done. 08:30:53 INFO - Return code: 0 08:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:30:54 INFO - Reading from file tmpfile_stdout 08:30:54 INFO - Output received: 08:30:54 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) 08:30:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:30:54 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')]} 08:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:54 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')]} 08:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:54 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:30:54 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 08:30:54 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 08:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:30:54 INFO - 'HOME': '/Users/cltbld', 08:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:30:54 INFO - 'LOGNAME': 'cltbld', 08:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:54 INFO - 'MOZ_NO_REMOTE': '1', 08:30:54 INFO - 'NO_EM_RESTART': '1', 08:30:54 INFO - 'PAGER': '/bin/cat', 08:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:54 INFO - 'PWD': '/builds/slave/test', 08:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:30:54 INFO - 'SHELL': '/bin/bash', 08:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:30:54 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:30:54 INFO - 'USER': 'cltbld', 08:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:54 INFO - 'XPC_FLAGS': '0x0', 08:30:54 INFO - 'XPC_SERVICE_NAME': '0', 08:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:54 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 08:30:54 INFO - Cleaning up... 08:30:54 INFO - Return code: 0 08:30:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:30:54 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')]} 08:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:54 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')]} 08:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:54 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:30:54 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 08:30:54 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 08:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:30:54 INFO - 'HOME': '/Users/cltbld', 08:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:30:54 INFO - 'LOGNAME': 'cltbld', 08:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:54 INFO - 'MOZ_NO_REMOTE': '1', 08:30:54 INFO - 'NO_EM_RESTART': '1', 08:30:54 INFO - 'PAGER': '/bin/cat', 08:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:54 INFO - 'PWD': '/builds/slave/test', 08:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:30:54 INFO - 'SHELL': '/bin/bash', 08:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:30:54 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:30:54 INFO - 'USER': 'cltbld', 08:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:54 INFO - 'XPC_FLAGS': '0x0', 08:30:54 INFO - 'XPC_SERVICE_NAME': '0', 08:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:30:54 INFO - Downloading/unpacking psutil>=3.1.1 08:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:58 INFO - Installing collected packages: psutil 08:30:58 INFO - Running setup.py install for psutil 08:30:58 INFO - building 'psutil._psutil_osx' extension 08:30:58 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 08:30:58 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 08:30:58 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 08:30:58 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 08:30:58 INFO - building 'psutil._psutil_posix' extension 08:30:58 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 08:30:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:30:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:30:58 INFO - ^ 08:30:58 INFO - 1 warning generated. 08:30:58 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 08:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:30:58 INFO - Successfully installed psutil 08:30:58 INFO - Cleaning up... 08:30:59 INFO - Return code: 0 08:30:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:30:59 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')]} 08:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:59 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')]} 08:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:30:59 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:30:59 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 08:30:59 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 08:30:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:30:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:30:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:30:59 INFO - 'HOME': '/Users/cltbld', 08:30:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:30:59 INFO - 'LOGNAME': 'cltbld', 08:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:59 INFO - 'MOZ_NO_REMOTE': '1', 08:30:59 INFO - 'NO_EM_RESTART': '1', 08:30:59 INFO - 'PAGER': '/bin/cat', 08:30:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:59 INFO - 'PWD': '/builds/slave/test', 08:30:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:30:59 INFO - 'SHELL': '/bin/bash', 08:30:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:30:59 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:30:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:30:59 INFO - 'USER': 'cltbld', 08:30:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:30:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:59 INFO - 'XPC_FLAGS': '0x0', 08:30:59 INFO - 'XPC_SERVICE_NAME': '0', 08:30:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:31:02 INFO - Installing collected packages: mozsystemmonitor 08:31:02 INFO - Running setup.py install for mozsystemmonitor 08:31:02 INFO - Successfully installed mozsystemmonitor 08:31:02 INFO - Cleaning up... 08:31:03 INFO - Return code: 0 08:31:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:31:03 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')]} 08:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:03 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')]} 08:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:03 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:03 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 08:31:03 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 08:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:03 INFO - 'HOME': '/Users/cltbld', 08:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:03 INFO - 'LOGNAME': 'cltbld', 08:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:03 INFO - 'MOZ_NO_REMOTE': '1', 08:31:03 INFO - 'NO_EM_RESTART': '1', 08:31:03 INFO - 'PAGER': '/bin/cat', 08:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:03 INFO - 'PWD': '/builds/slave/test', 08:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:03 INFO - 'SHELL': '/bin/bash', 08:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:03 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:03 INFO - 'USER': 'cltbld', 08:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:03 INFO - 'XPC_FLAGS': '0x0', 08:31:03 INFO - 'XPC_SERVICE_NAME': '0', 08:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:31:05 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 08:31:05 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 08:31:05 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 08:31:05 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 08:31:05 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 08:31:05 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 08:31:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:06 INFO - warning: no files found matching '*.txt' 08:31:06 INFO - no previously-included directories found matching 'build' 08:31:06 INFO - no previously-included directories found matching 'dist' 08:31:06 INFO - no previously-included directories found matching '.git*' 08:31:06 INFO - Installing collected packages: jsonschema, functools32 08:31:06 INFO - Running setup.py install for functools32 08:31:06 INFO - warning: no files found matching '*.txt' 08:31:06 INFO - no previously-included directories found matching 'build' 08:31:06 INFO - no previously-included directories found matching 'dist' 08:31:06 INFO - no previously-included directories found matching '.git*' 08:31:06 INFO - Successfully installed jsonschema functools32 08:31:06 INFO - Cleaning up... 08:31:06 INFO - Return code: 0 08:31:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:06 INFO - 'HOME': '/Users/cltbld', 08:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:06 INFO - 'LOGNAME': 'cltbld', 08:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:06 INFO - 'MOZ_NO_REMOTE': '1', 08:31:06 INFO - 'NO_EM_RESTART': '1', 08:31:06 INFO - 'PAGER': '/bin/cat', 08:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:06 INFO - 'PWD': '/builds/slave/test', 08:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:06 INFO - 'SHELL': '/bin/bash', 08:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:06 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:06 INFO - 'USER': 'cltbld', 08:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:06 INFO - 'XPC_FLAGS': '0x0', 08:31:06 INFO - 'XPC_SERVICE_NAME': '0', 08:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:31:07 INFO - Cleaning up... 08:31:07 INFO - Return code: 0 08:31:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:07 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 08:31:07 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 08:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:07 INFO - 'HOME': '/Users/cltbld', 08:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:07 INFO - 'LOGNAME': 'cltbld', 08:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:07 INFO - 'MOZ_NO_REMOTE': '1', 08:31:07 INFO - 'NO_EM_RESTART': '1', 08:31:07 INFO - 'PAGER': '/bin/cat', 08:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:07 INFO - 'PWD': '/builds/slave/test', 08:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:07 INFO - 'SHELL': '/bin/bash', 08:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:07 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:07 INFO - 'USER': 'cltbld', 08:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:07 INFO - 'XPC_FLAGS': '0x0', 08:31:07 INFO - 'XPC_SERVICE_NAME': '0', 08:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:07 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 08:31:07 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 08:31:07 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 08:31:07 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 08:31:07 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 08:31:07 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 08:31:09 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:09 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 08:31:09 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 08:31:09 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 08:31:09 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 08:31:09 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 08:31:09 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 08:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:31:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:11 INFO - Downloading docopt-0.6.1.tar.gz 08:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:11 INFO - Running setup.py install for blobuploader 08:31:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:31:11 INFO - Running setup.py install for requests 08:31:11 INFO - Running setup.py install for docopt 08:31:11 INFO - Successfully installed blobuploader requests docopt 08:31:11 INFO - Cleaning up... 08:31:12 INFO - Return code: 0 08:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31: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')]} 08:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:12 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:12 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 08:31:12 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 08:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:12 INFO - 'HOME': '/Users/cltbld', 08:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:12 INFO - 'LOGNAME': 'cltbld', 08:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:12 INFO - 'MOZ_NO_REMOTE': '1', 08:31:12 INFO - 'NO_EM_RESTART': '1', 08:31:12 INFO - 'PAGER': '/bin/cat', 08:31:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:12 INFO - 'PWD': '/builds/slave/test', 08:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:12 INFO - 'SHELL': '/bin/bash', 08:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:12 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:12 INFO - 'USER': 'cltbld', 08:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:12 INFO - 'XPC_FLAGS': '0x0', 08:31:12 INFO - 'XPC_SERVICE_NAME': '0', 08:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-_YEUFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-bC91lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-3XEAfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-eQFJA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-gWCduO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-C_E5g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Q40x_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-tZhaBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-VNBXN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-9xOBcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-F1u0Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-N_BUTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-RgX7VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-E4k75f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-KUXkUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:13 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-G_UeSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:14 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-gjBI38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:14 INFO - Running setup.py install for manifestparser 08:31:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:31:14 INFO - Running setup.py install for mozcrash 08:31:14 INFO - Running setup.py install for mozdebug 08:31:14 INFO - Running setup.py install for mozdevice 08:31:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:31:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:31:14 INFO - Running setup.py install for mozfile 08:31:14 INFO - Running setup.py install for mozhttpd 08:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for mozinfo 08:31:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for mozInstall 08:31:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for mozleak 08:31:15 INFO - Running setup.py install for mozlog 08:31:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for moznetwork 08:31:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:31:15 INFO - Running setup.py install for mozprocess 08:31:15 INFO - Running setup.py install for mozprofile 08:31:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozrunner 08:31:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Running setup.py install for mozscreenshot 08:31:16 INFO - Running setup.py install for moztest 08:31:16 INFO - Running setup.py install for mozversion 08:31:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:31:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:16 INFO - Cleaning up... 08:31:16 INFO - Return code: 0 08:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:16 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')]} 08:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:16 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')]} 08:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:16 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:16 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 08:31:16 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 08:31:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:16 INFO - 'HOME': '/Users/cltbld', 08:31:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:16 INFO - 'LOGNAME': 'cltbld', 08:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:16 INFO - 'MOZ_NO_REMOTE': '1', 08:31:16 INFO - 'NO_EM_RESTART': '1', 08:31:16 INFO - 'PAGER': '/bin/cat', 08:31:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:16 INFO - 'PWD': '/builds/slave/test', 08:31:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:16 INFO - 'SHELL': '/bin/bash', 08:31:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:16 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:16 INFO - 'USER': 'cltbld', 08:31:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:16 INFO - 'XPC_FLAGS': '0x0', 08:31:16 INFO - 'XPC_SERVICE_NAME': '0', 08:31:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-GFaUTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-NyLO4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Vt2tKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-T1gPMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-faoHQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-0igVmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-UnG3tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-DkHitn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-PeG4jC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:17 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)) 08:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-1_AzW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-zZU60H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-P8lHuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-oj6Eru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Lucyag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-9zHGrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-Lm20Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:18 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)) 08:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-KRg_3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:18 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)) 08:31:18 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)) 08:31:18 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)) 08:31:18 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)) 08:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:18 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 08:31:18 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 08:31:18 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 08:31:18 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 08:31:18 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 08:31:18 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 08:31:21 INFO - Downloading blessings-1.6.tar.gz 08:31:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:21 INFO - Installing collected packages: blessings 08:31:21 INFO - Running setup.py install for blessings 08:31:21 INFO - Successfully installed blessings 08:31:21 INFO - Cleaning up... 08:31:21 INFO - Return code: 0 08:31:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:22 INFO - Reading from file tmpfile_stdout 08:31:22 INFO - Current package versions: 08:31:22 INFO - blessings == 1.6 08:31:22 INFO - blobuploader == 1.2.4 08:31:22 INFO - docopt == 0.6.1 08:31:22 INFO - functools32 == 3.2.3-2 08:31:22 INFO - jsonschema == 2.5.1 08:31:22 INFO - manifestparser == 1.1 08:31:22 INFO - mozInstall == 1.12 08:31:22 INFO - mozcrash == 1.0 08:31:22 INFO - mozdebug == 0.1 08:31:22 INFO - mozdevice == 0.48 08:31:22 INFO - mozfile == 1.2 08:31:22 INFO - mozhttpd == 0.7 08:31:22 INFO - mozinfo == 0.9 08:31:22 INFO - mozleak == 0.1 08:31:22 INFO - mozlog == 3.4 08:31:22 INFO - moznetwork == 0.27 08:31:22 INFO - mozprocess == 0.23 08:31:22 INFO - mozprofile == 0.28 08:31:22 INFO - mozrunner == 6.13 08:31:22 INFO - mozscreenshot == 0.1 08:31:22 INFO - mozsystemmonitor == 0.3 08:31:22 INFO - moztest == 0.8 08:31:22 INFO - mozversion == 1.4 08:31:22 INFO - psutil == 3.1.1 08:31:22 INFO - requests == 1.2.3 08:31:22 INFO - wsgiref == 0.1.2 08:31:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:22 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:22 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 08:31:22 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 08:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:22 INFO - 'HOME': '/Users/cltbld', 08:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:22 INFO - 'LOGNAME': 'cltbld', 08:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:22 INFO - 'MOZ_NO_REMOTE': '1', 08:31:22 INFO - 'NO_EM_RESTART': '1', 08:31:22 INFO - 'PAGER': '/bin/cat', 08:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:22 INFO - 'PWD': '/builds/slave/test', 08:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:22 INFO - 'SHELL': '/bin/bash', 08:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:22 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:22 INFO - 'USER': 'cltbld', 08:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:22 INFO - 'XPC_FLAGS': '0x0', 08:31:22 INFO - 'XPC_SERVICE_NAME': '0', 08:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 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)) 08:31:22 INFO - Cleaning up... 08:31:22 INFO - Return code: 0 08:31:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:22 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 0x10ca5a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9743dd0220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, '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.sGMZDImYAS/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.C9EKxLTFPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 08:31:22 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 08:31:22 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 08:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:22 INFO - 'HOME': '/Users/cltbld', 08:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:22 INFO - 'LOGNAME': 'cltbld', 08:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:22 INFO - 'MOZ_NO_REMOTE': '1', 08:31:22 INFO - 'NO_EM_RESTART': '1', 08:31:22 INFO - 'PAGER': '/bin/cat', 08:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:22 INFO - 'PWD': '/builds/slave/test', 08:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:22 INFO - 'SHELL': '/bin/bash', 08:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:22 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:22 INFO - 'USER': 'cltbld', 08:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:22 INFO - 'XPC_FLAGS': '0x0', 08:31:22 INFO - 'XPC_SERVICE_NAME': '0', 08:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:31:22 INFO - Cleaning up... 08:31:22 INFO - Return code: 0 08:31:22 INFO - Running post-action listener: _resource_record_post_action 08:31:22 INFO - Running post-action listener: _start_resource_monitoring 08:31:22 INFO - Starting resource monitoring. 08:31:22 INFO - [mozharness: 2017-02-13 16:31:22.714047Z] Finished create-virtualenv step (success) 08:31:22 INFO - [mozharness: 2017-02-13 16:31:22.715088Z] Running install step. 08:31:22 INFO - Running pre-action listener: _resource_record_pre_action 08:31:22 INFO - Running main action method: install 08:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:22 INFO - Reading from file tmpfile_stdout 08:31:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:31:23 INFO - Reading from file tmpfile_stdout 08:31:23 INFO - Output received: 08:31:23 INFO - Usage: mozinstall [options] installer 08:31:23 INFO - Options: 08:31:23 INFO - -h, --help show this help message and exit 08:31:23 INFO - -d DEST, --destination=DEST 08:31:23 INFO - Directory to install application into. [default: 08:31:23 INFO - "/builds/slave/test"] 08:31:23 INFO - --app=APP Application being installed. [default: firefox] 08:31:23 INFO - mkdir: /builds/slave/test/build/application 08:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:31:44 INFO - Reading from file tmpfile_stdout 08:31:44 INFO - Output received: 08:31:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:31:44 INFO - Running post-action listener: _resource_record_post_action 08:31:44 INFO - [mozharness: 2017-02-13 16:31:44.962033Z] Finished install step (success) 08:31:44 INFO - [mozharness: 2017-02-13 16:31:44.962206Z] Running run-tests step. 08:31:44 INFO - Running pre-action listener: _resource_record_pre_action 08:31:44 INFO - Running main action method: run_tests 08:31:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:31:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:31:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:31:44 INFO - 2017-02-13 08:31:44.976 screenresolution[2180:25236] starting screenresolution argv=screenresolution get 08:31:44 INFO - 2017-02-13 08:31:44.979 screenresolution[2180:25236] Display 0: 1600x1200x32@60 08:31:44 INFO - 2017-02-13 08:31:44.985 screenresolution[2181:25238] starting screenresolution argv=screenresolution list 08:31:44 INFO - Available Modes on Display 0 08:31:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:31:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:31:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:31:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:31:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:31:45 INFO - Intel Iris: 08:31:45 INFO - Chipset Model: Intel Iris 08:31:45 INFO - Type: GPU 08:31:45 INFO - Bus: Built-In 08:31:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:31:45 INFO - Vendor: Intel (0x8086) 08:31:45 INFO - Device ID: 0x0a2e 08:31:45 INFO - Revision ID: 0x0009 08:31:45 INFO - Displays: 08:31:45 INFO - Display: 08:31:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:31:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:31:45 INFO - Display Serial Number: 1600x1200 60 08:31:45 INFO - Main Display: Yes 08:31:45 INFO - Mirror: Off 08:31:45 INFO - Online: Yes 08:31:45 INFO - Rotation: Supported 08:31:45 INFO - Return code: 0 08:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:31:45 INFO - Python 2.7.3 08:31:45 INFO - Return code: 0 08:31:45 INFO - grabbing minidump binary from tooltool 08:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c86ed30>, '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 0x10c6d4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c866b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:31:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:31:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:31:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:31:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:31:45 INFO - Return code: 0 08:31:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:31:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:31:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:31:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:31:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 08:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --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 08:31:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sGMZDImYAS/Render', 08:31:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:45 INFO - 'HOME': '/Users/cltbld', 08:31:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:45 INFO - 'LOGNAME': 'cltbld', 08:31:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:31:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:45 INFO - 'MOZ_NO_REMOTE': '1', 08:31:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:31:45 INFO - 'NO_EM_RESTART': '1', 08:31:45 INFO - 'PAGER': '/bin/cat', 08:31:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:45 INFO - 'PWD': '/builds/slave/test', 08:31:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:31:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:45 INFO - 'SHELL': '/bin/bash', 08:31:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C9EKxLTFPR/Listeners', 08:31:45 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 08:31:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:45 INFO - 'USER': 'cltbld', 08:31:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:45 INFO - 'XPC_FLAGS': '0x0', 08:31:45 INFO - 'XPC_SERVICE_NAME': '0', 08:31:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 08:31:45 INFO - mozversion application_buildid: 20170213053639 08:31:45 INFO - mozversion application_changeset: f984c74df66ca1fce52d414fe9cba21b16298fe4 08:31:45 INFO - mozversion application_display_name: Firefox 08:31:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:45 INFO - mozversion application_name: Firefox 08:31:45 INFO - mozversion application_remotingname: firefox 08:31:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:31:45 INFO - mozversion application_vendor: Mozilla 08:31:45 INFO - mozversion application_version: 52.0 08:31:45 INFO - mozversion platform_buildid: 20170213053639 08:31:45 INFO - mozversion platform_changeset: f984c74df66ca1fce52d414fe9cba21b16298fe4 08:31:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:31:45 INFO - mozversion platform_version: 52.0 08:31:45 INFO - using testdate: 1487003505 08:31:45 INFO - actual date: 1487003505 08:31:45 INFO - starting webserver on 'localhost:57422' 08:31:45 INFO - SUITE-START | Running 2 tests 08:31:45 INFO - TEST-START | dromaeo_css 08:31:45 INFO - operating with platform_type : mac_ 08:31:45 INFO - Initialising browser for dromaeo_css test... 08:31:45 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp4qglQl/profile http://localhost:57422/getInfo.html) 08:31:48 INFO - PROCESS | 2191 | __metrics Screen width/height:1600/1200 08:31:48 INFO - PROCESS | 2191 | colorDepth:24 08:31:48 INFO - PROCESS | 2191 | Browser inner width/height: 1024/689 08:31:48 INFO - PROCESS | 2191 | __metrics 08:31:48 INFO - PROCESS | 2191 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:31:48 INFO - PROCESS | 2191 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:49 INFO - TEST-INFO | 2191: exit 0 08:31:49 INFO - Browser initialized. 08:31:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:31:49 INFO - TEST-INFO | started process 2194 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp4qglQl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:01 INFO - PROCESS | 2194 | RSS: Main: 171900928 08:32:01 INFO - PROCESS | 2194 | 08:35:04 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57422/tests/dromaeo/cssquery-ext.html) 08:35:06 INFO - PROCESS | 2194 | RSS: Main: 322138112 08:35:06 INFO - PROCESS | 2194 | 08:38:08 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-ext.html (next: http://localhost:57422/tests/dromaeo/cssquery-jquery.html) 08:38:09 INFO - PROCESS | 2194 | RSS: Main: 301473792 08:38:09 INFO - PROCESS | 2194 | 08:41:11 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57422/tests/dromaeo/cssquery-mootools.html) 08:41:12 INFO - PROCESS | 2194 | RSS: Main: 272871424 08:41:12 INFO - PROCESS | 2194 | 08:44:14 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57422/tests/dromaeo/cssquery-prototype.html) 08:44:15 INFO - PROCESS | 2194 | RSS: Main: 266514432 08:44:15 INFO - PROCESS | 2194 | 08:47:18 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57422/tests/dromaeo/cssquery-yui.html) 08:47:19 INFO - PROCESS | 2194 | RSS: Main: 259301376 08:47:19 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | Cycle 1(1): loaded http://localhost:57422/tests/dromaeo/cssquery-yui.html (next: http://localhost:57422/tests/dromaeo/cssquery-dojo.html) 08:50:22 INFO - PROCESS | 2194 | RSS: Main: 371093504 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | __start_tp_report 08:50:22 INFO - PROCESS | 2194 | _x_x_mozilla_page_load 08:50:22 INFO - PROCESS | 2194 | _x_x_mozilla_page_load_details 08:50:22 INFO - PROCESS | 2194 | |i|pagename|runs| 08:50:22 INFO - PROCESS | 2194 | |0;dojo.html;2994.5059065254236;3413.4709120086386;3422.5454181972673;3441.518187453755;3488.9476657850137;5568.16477528371;5674.943250567493;5678.943210567893;5699.829005129843;5704.600677952545;5620.522255608278;5674;5748.971255143719;5760.510356619682;5763.942360576393;5135.229715542661;5182.637215394924;5182.714950677711;5186.7147306898105;5253.50091741284;5119.283300337956;5160.096983027974;5212.6611770235;5222.843314700565;5267.578593712513;5228.006678731029;5229.738513074331;5235.581153507729;5250.553702935255;5258.710770907599;5223.477652234784;5231.607629427808;5233.241180028913;5251.159814429711;5309.787608495655;5096.490350964911;5113;5157.097507936096;5172.431032586413;5203.713795741232;5635.267415236034;5647.774089036475;5722.914156287659;5738.741756620962;5740.253767010304;6169.290531588835;6231.127642130105;6271.78048768291;6280.87438251237;6284.5600807943465;6360.109584658151;6360.491160707133;6376.139221205124;6379.362063793584;6381.521385896076;5666.5183459406;5673.773049078032;5746.109353050284;5815.912761308584;5851.619644723164;6255.80026144834;6301.936980630227;6309.747610095636;6321.936780632135;6333.366663333722;6033.7586496540525;6222.346653601307;6234;6241.157443745127;6249.562530622813;4984.27727979441;6170.10533472644;6235.220597425322;6244.625322480666;6271.184745982993;6224.221972253468;6246.531510136667;6252.280987686383;6258.186435763413;6268.561200715906;6233.0338797486465;6302.1177035215105;6302.621842689453;6320.178376811077;6323.399277068763;4893;4933.062718083553;4941.530554597308;4958.157113290749;5011.022850544182;4390.4511936008;4436.3123715824095;4457.375967364572;4508.616767574727;4512.796924138422;5913.379095195029;5914.408559144051;5918;5944.256967879015;5953.1070339449425;6102.633841969496;6153.784617538365;6228.813135605939;6229.813105606839;6246.843828904313;5762.9135562966585;5829.679367634821;5848.736806843703;5907.054871220584;5908.261467316585;5433.6196466247775;5456.372517160498;5457.045017122067;5473.0969390051;5502.202180683778;6373.617582945131;6379.457746091634;6383.680815959091;6413.935860641333;6428.839279018062;6010.969945150421;6124;6200.782972595937;6222.688865556614;6232.314445411092;6223.657698826608;6227.19046523949;6229.813105606839;6324.525660575383;6377.202849643794;6188.4739797117745;6199.535034872493;6213.782517611862;6215.533834962305;6217.067439883873;6118.741008805849;6186.690665466798;6222.719977600928;6223.875522489434;6234.688265586612;6096.329403765493;6110.961136606877;6124;6127.356627554221;6187.1647327612;6177;6183.752649893954;6191.349908259568;6201.193844800147;6205.131281620667;5001.624878134082;5881.264841894763;6043.153958445909;6059.424354686298;6112.572119951561;5897.203877476657;5955.553333499918;6024.367441418588;6063.5452341073715;6096.542759292982;5964.97017514927;5968.880622387441;5973.611715238496;5981.611195272293;5989.64062156272 08:50:22 INFO - PROCESS | 2194 | |1;ext.html;526.4183077699142;534.6978956889359;544.1266766839223;552.2241251042284;574.8936446757352;30519.542206866914;32754.67245327546;32767.50848737271;42737.57262427375;44309;43737.56262437375;44232.778836105776;44340.33489497652;44394.77802610982;44479.11041779163;9462.243020558357;9626.278029147807;9630;9652.565634546427;9686.806263874718;9400.294977876652;9527.857082143773;9531;9535.523223838814;9542.570584323686;9496.43021418717;9533.666321678742;9539.666111686092;9544.568314752772;9577.521123943776;9482.857757133614;9519.666811661558;9533.666321678707;9538.236941044734;9538.904610953941;9524.285678574135;9607.615695372177;9610.567524461416;9613.51932403377;9614.990426005239;40791.59208407937;41123.38314925278;41170.38244426336;41270;41421.58578414207;3155.2900597365638;3735.4583585380237;3951.8616848410165;3966.880993570169;3966.920661586752;29813.850930745426;29902;29952.400951981057;31149.065528034196;31330.843345783127;3150.9054728358187;3291.8024918504725;3313.96686033139;3373.3084717633074;3448.3103379324234;488921;492751;495712;496631;498468;33602.66397336044;33607.49588756171;33689.98930032103;64107.67946160239;64730;35331;35470.822645886605;35510;35553;35637.28725425477;14673.559793206221;14795.964282500121;14858;14872.182029988238;14875.628109297355;12466.563670271496;12526.436310366056;12531.43608537618;12540.24758514492;12552.309622970643;7845.607719613997;7888.974433323746;7936.841263174704;7937.880931786028;8045.879311810328;3305.2397948471985;3312.0560640217423;3316.369889720945;3324.335132973415;3366.1248075500057;902.6882253744747;933.3979583168954;992.712113487095;1010.5755582655303;1038.0605551975323;28272.8586357071;29930.70069299323;29987;30624.92812751543;30832.691673082983;989.8020395920845;1054.8945105489543;1055.7941201465794;1065.6270305393205;1099.8570185875785;15419.61450963735;15536.456224032105;15851.841481585267;16057.357705691642;16108.812649669697;565244.0426787203;652273;655957;656252.5936851617;657297;59830.70084649549;60382.09426858601;60470.697646511486;60536.697316513135;60698;1281.8910392616733;1312.4815697799315;1313.6453157647572;1400.1948879394592;1416.2706206303762;29151.562726558695;30451.390972180874;30682.84658576693;30769;31142.844285778425;48520.514794853014;49136.75431622819;49653.751731241115;50112.74943625258;50216;543224;544288;544456;544854;545298;24434.633480498163;25691.614625780254;26009.869950650882;27584.862075690296;28074;44974.55025449704;45262.54737452715;45882;46442.76778616221;46519.53480465152;37081.81459092687;37355.439668404455;37414.94217818046;37598;38690.613093869826;38864.80567597144;39058.80470597629;40004;40186.598134019456;40375;37075;37426.690065847564;37499.81250093732;37558.2488350226;38055;33160.668393315755;34091.82954085214;35012.47481287834;35056.94829155129;35063.82468087643;25571.74428255768;25581.104661336765;25784.613230801177;25798.09706660258;26149.869250653624 08:50:22 INFO - PROCESS | 2194 | |2;jquery.html;328.723871947564;365.1218818740927;381.4392842521494;391.31910475772145;414.1179288116312;17034.403795867147;19899.701504477445;21552.137914483403;21752.782472175273;21784.8910755446;19767.901160494177;19987.700184497244;20509.794902050977;20860.165593376245;21052.57894842102;5564.916526252109;5577.3028371453565;5594.342687223577;5606.299212598426;5944.197533332988;4232.74603523788;5838.9124163137585;5925.377835327272;5946.43508866657;5952.166696662471;4265.210935976838;4438.556144385568;4479.686421950465;4482.282834746441;6468.4825213983;6462.5153113516435;6478.773242936474;6485.221773387177;6487.83780405489;6489.48084153269;5131.4098878629065;5394.32570928634;5450.591205659552;5478.808241711561;5502.339719233678;12895.09734318598;13178;16206.35174593015;21034.78965210359;25910.87044564765;2036.5825005873908;2294.66727324537;2309.58427483053;2324.6164382876805;2325.860448373103;9939.304248702594;10055.748606284827;10371.429571373572;11482.024027957634;15482.922585387001;1765.0997991024542;1774.6361995790833;1785.61609254011;1855.879367841086;1856.1740025688573;109769.90230097677;126734;130012.04981925279;130884;134357.98463022965;11343.489542970587;11696.590619328283;11776.17566770335;11787.880151385605;12084.885953726516;14986.625334366729;14988.775168372484;15033.173175475235;15033.548993530212;15084.622884427758;8513.318934485227;8649.308055355556;8689.391742577958;8733.51965641883;8756.168164024408;8559.871601925975;8571;8576.528290944058;8671.913280867237;8722.956385218033;4488.3940668010055;4586.495485496593;4587.72473651582;4595.264399390833;4662.673612847136;1626.725916521205;1875.8874467531991;1913.425972208332;1915.4828196386898;1941.1555973151724;901.1112380592795;912.1289168843738;949.539473355422;963.3930623707159;985.0641890204334;20237.08933097985;20975;21846.680873947054;21959;22013.449663758212;785.3010820369875;915.949622770754;922.820050090226;932.2076235200026;936.7002559181133;10961.232713710124;11373.221532049798;11450.885491144982;11563.6530904073;11587.478563464665;535656;595907;602530;618146;626710;132942;134150.3292483551;137486;139223.30388348197;144094.27952860168;961.3078583419926;969.5346233807671;996.5764550066193;998.3510718033336;998.5656239535825;18834;19273.325433610316;19359.612807744048;19539.120739566468;19594.216231350587;53990.46009539854;54240.3727888164;54808.17787733107;56306;56680.71659641675;78944;80155;82800;85389;86593.70109448489;7253.601051941982;7496.437767167376;7548.358389536731;8039.437239393186;8529.104444033535;9244.630214791334;12655.493780248687;13157.868421315665;13600.387982540611;13764;5485.930243602459;8116.553589552631;9890.208783297463;11149.108071354434;11669.299842009506;10270.178385729274;10445.477726113815;11406.14453915943;11654.475548600163;11833.171677982458;11483.712907177387;11802.291862488279;12051.638450846489;12072.637820865388;12206.206596571194;7340.449466290156;7602.277783610548;7654.655540500802;7750.0699916010435;8007.519548827089;8804.427712198687;9936.20510359155;11443.942780286045;11628.53485860556;11906.523739050688 08:50:22 INFO - PROCESS | 2194 | |3;mootools.html;1322.5371120107961;1366.7835626292594;1465.7361674898518;1594.5216435069476;1825.0053720722196;6689.531732778707;7988.36093112551;8198.262156405923;8444.324454043677;8455.788605284872;8342.499450033003;8385.203405676466;8394;8407.369447291447;8417.158284171579;2367.6566897799853;2406.1578447543393;2408.2534414331612;2408.277516744978;2408.4460574067975;2372.620380739082;2421.225207933462;2423.3456966619;2430.3802530354733;2430.5260474207535;2077.5844831033855;2307.711536057993;2315.444293369596;2356.8350215484925;2381.452265978826;2300.66640337151;2324.1284518305633;2360.5514952159033;2365.5860224460653;2365.680633114525;1973.9309124180584;2370.767201055459;2392.964105538418;2394.4133687246563;2396.1493669747165;7634.274743899321;7803.790412486017;8267.379946503976;8328.541930193836;8426.241638252526;5023.673461225008;5064.215046667772;5184.11869982104;5187.455317191716;5188.948110518884;3351.497275408708;3510.403231450634;3604.981975090134;3615.6384361563896;3624.691901188402;1080.1089101491223;1093.2347356850157;1098.5166526728215;1121.9719507012308;1128.2609890521721;9145.314101442418;11051.889481105167;11132.276402033924;11142.442877856074;11170;4312.180685669713;4450.977745111254;4510.7068040577915;4544.0457503924545;4545.477270113913;8650.6972255972;8659.52372619512;8667.219950204511;8692.95653521741;8702.173293537104;5108.3103780989095;5115.360579927509;5119.462456442095;5120.948790512047;5137.8201762938115;3737.1404576947452;4257.829686812554;4301.204277208726;4350.499692535335;4745.240761478216;3526.171349732862;3694.852205911787;3794.2601192767697;3801.3157631626573;3821.7133714971487;997.7006897930592;1134.4214450630238;1147.437755499799;1149.36210403227;1163.2322667039714;726.8364617960916;749.79380670315;777.766669998998;845.2097289034772;892.8705337726124;5293.609757549946;5334.359876814729;5480.6437581557075;5519.199716041152;5554.08357620988;416.6500139882453;416.91870085333676;418.15323968963094;424.6496640271788;430.6597787747707;3314.734821214297;3410.1474631342167;3593.6047034826147;3668.5781135169796;3814.6948244140403;9953.402795832273;10286.742831429125;10415.479226038668;10432.634857779942;10455.738606534898;10377.429241391796;10379.325343852626;10389.53247103867;10399.688009359732;10438.843417348746;7771.805704857424;7774.067111946602;7838.216178382117;7884.605769711607;7937.166597507178;5273.973630131978;5299.655522391032;5436.937586023644;5539.667619942817;5612.045952188219;9492.145706886413;9529.952350238482;9537.380070295409;9558.56986435598;9559.713208603753;7512.624368781429;8796.516191609522;9076.455412675261;9502.429854208769;9503;6732.9663351684885;7028.0863487746265;7150.570965741864;7192.388646965067;7293.598852063187;7770.844583108419;7871.803204919694;7955.761327160194;8065;8070.677172913018;5579.525740311957;7069.363757261871;7154.141503019671;7254.5647261164495;7278.599677017814;7022.894656580258;7028.718851245892;7048.259932706992;7077.469189810682;7137.250588688113;6522.967385163044;6712.6979285931275;6721.596704197764;6811.114555107804;6824.556403833735;4605.884852878705;4706.958068715962;4718.787654555622;4831.685940413862;4927.60579153674;4758.4765675776325;4798.2802579613335;4824.445188803333;4842.055799119138;4865.683730557503 08:50:22 INFO - PROCESS | 2194 | |4;prototype.html;308.92431354318194;309.90392978176754;317.1563640715695;319.8464736926275;323.2210373001068;5170.896582068361;5171.508706672865;5270.288511051007;5292.576593872491;5302.522772950443;4045.817938192781;4838.371011768465;4922.778474968626;5176.456472070435;5204.32343795307;3588.910277243077;3624.87312944047;3655.8903232903053;3787.367779393323;3890.533136023681;3733.589305176442;3738.738288319819;3951.940720889189;3974.1256923476935;3978.7413818101877;3526.9294614107703;3726.441033844918;3795.259924314746;3987.182627561343;4002.9799851000703;3209.9839500802464;3555.9466608000903;3782.508273924386;3949.269385163754;3964.762114273124;3086.8302243376606;3432.4508078707286;3441.397755392796;3449.3273811606746;3461.809600471973;4538.636909047268;4547.226971414867;4819.349387832633;4926.729029903354;5116;3722.7207959403154;4319.568043195687;4396.428464299621;4507.166174257773;4571.9542804571865;5453.291072160594;5474.863128421782;5475.863103422406;5484.890302193974;5493.945060549383;3430.8627654893776;3855.4409610606303;3869.129445874684;3889;3901.453796468497;5057.241413787924;5192.417232109832;5481.561475081984;5493.560515158778;5816.243888294494;3390.2371966307383;3776.9046976376544;3881.1849511602313;3908.765474071508;3921.450996860442;3471.94792078119;3702.1114932416563;3974.8201438848805;3983.223271462095;3991.6270751215175;3652.7625704329134;4357.888738371695;4392.604665580113;4587.334836448763;4607.193741095362;4667.439907211156;5155.576878866927;5463.945360546423;5494.955958367897;5505.752241149158;1147.8737338892715;1286.4854058376536;1291.3607764156802;1295.475332490343;1301.7201301720177;840.995795021021;852.6418904060309;873.2097451806126;874.7157173918501;891.7458524320538;4232.4551538688775;4441.911161776747;4803.543663351976;4814.109389762905;5278;5348.946510534923;5355.928814237168;5673.461021202979;5674.574406919498;5704.0588302929555;4862.708237505761;5236.73816309183;5262.342207224097;5341.732913354317;5351.565037907742;2469.6295555666793;2654.2568080937367;2656.2031390582747;2787.76304014157;2791.5114854900717;4546.317862390871;5137.099273268915;5520.3651580068;5530.511269928548;5586.804461843816;4710.81156753726;4897.926531102036;5403.972980135153;5517.675757818095;5575.944240557543;4721.386219791405;4795.688280261772;4950.356453661073;5600.411956744565;5693.800716974886;4991.276264941635;5414.3232095988005;5458.426865179258;5471.616986811045;5489.231507589021;4454.665900057574;5251.531780063364;5263.710495922761;5266.473352664703;5369.919451208157;4322.78386080701;4459.550646039985;4629.537046295343;5515.393306736336;5594.1608758686525;3088.351446196234;3254.8535315910367;3608;3665.7067434604633;3675.852965881335;4731.337612734289;4734.621230301636;4739.668223224341;5403.811751066889;5459.890802184013;4430.512643609136;4645.953540464552;5002.274670172732;5092.567131793691;5299.284596579412;4892.608591312757;5159.303494028258;5174.430812610534;5191.338771593205;5316.272211531191;4420.237351655215;4490.944628012479;4716.834910778106;5417.972910135424;5471.50756431923;5054.3176671150395;5341.439148889311;5428.945710542844;5456.890862182813;5512.862178445571;5390.595705322038;5420.620556561161;5439.646422982493;5440.972795136157;5471.316085489314 08:50:22 INFO - PROCESS | 2194 | |5;yui.html;693.2409012131715;701.771924124659;715.7938872998994;722.2380388689934;755.7128291249325;14437.855621443783;15332.310046047927;15341.156236406992;15347.769783453243;15366.846331536695;13672.931635341809;13803.2408217548;13812.447502099903;13829.377678004488;13837.100588461743;697.5849369625065;717.9102612173479;840.3907167303717;850.5492089192707;856.2251162697753;864.892937040589;869.1829680100717;878.9516576588285;880.2254016465502;885.3006125161115;941.2846236860001;942.6182396129578;944.3059351376733;945.6028468043404;945.6264775413707;930.1535602601667;933.0296491648711;933.3140141995627;933.7105497295826;935.6584846530967;680.6766785776766;685.1880521581942;688.1845013658831;690.1097584116484;690.9274526174729;12697;14526.927365363106;14855.851441485554;14945.775813362809;14966.925165374103;14342.641433964234;14616.26918654063;14635.780463293058;14659.926700366537;14804.70390592193;10916.836247456295;11213.551457941672;11248.606298779503;11688.532458701642;11734.354610496419;4488.4613846338325;4517.435320584927;4694.413198350207;4728.267118596623;4735.337052812609;90808;94082.99999999932;94778;94921;95160;10434.217433692504;10697.732556685989;10712.35725856451;10742.355458672504;10850.348979061124;19394.321198757974;19417;19549.804501955085;19618.21527138927;19650.803491965184;7527.962360188164;7609.581473019037;7666.693332266758;7699.961500192463;7826.178251283533;4237.978810105991;4319.200947824663;4335.197988372098;4402.141582391467;4490.236659767847;3115.4392209402527;3173.286010647586;3185.617725872864;3223.435898717762;3254;635.920509936258;639.4596565901805;642.877853207889;649.0815496073099;653.7025653327725;535.8610921265087;557.6486813307671;568.196002656245;601.885641728079;620.4973971083436;7658.425618078555;8291.908621813478;8488.490690558587;8555.786105347415;8682.325337593316;559.2701524510471;579.0359052178161;598.6168851934765;611;625.4496043481707;4158.875233742992;4220.746755194698;4236.682248831288;4246.235677578065;4323.329883868006;112359.43820280847;114285.4285728566;119258.40370798264;119551;119998;64084;65506.672466638316;67300.32699673038;82340.58829705813;104073;89807.55096224477;91607.62588561176;92573.07426925644;93911.06088939022;95547.52226238824;7110.3044368735755;7906.7627971160955;8190.590470476572;8262;8365.456245344034;34974;51122.48877511177;51517.484825152766;51545.7422712884;59816.40183598108;52429.47570524246;57251.71374143103;72452;75309;76325.61837190778;10885.292455990335;11202.159838012345;11234.269772464764;11619.709507262387;11698.94150529242;13703;14150.363233654716;14210.573682789533;14966.925165374103;14990.400383984956;12936.094473386773;13476;13533.796993044914;13744.65638359049;13910.51313204033;12468.68828279264;12725;12921.224726516439;13291;13854.445822167403;12491.375431228584;12786.61640150797;13033.087683862417;13360.732785344044;13729.038967272196;10215.7446063849;10676.46617669129;10962.451877405938;10997.450127493434;11048.779024419306;10754;10877.350491296198;11037.11703063737;11151.052160566443;11191.384473854016 08:50:22 INFO - PROCESS | 2194 | __end_tp_report 08:50:22 INFO - PROCESS | 2194 | __start_cc_report 08:50:22 INFO - PROCESS | 2194 | _x_x_mozilla_cycle_collect,1926 08:50:22 INFO - PROCESS | 2194 | __end_cc_report 08:50:22 INFO - PROCESS | 2194 | __startTimestamp1487004622663__endTimestamp 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | ------- Summary: start ------- 08:50:22 INFO - PROCESS | 2194 | Number of tests: 6 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#0] dojo.html Cycles:165 Average:5759.19 Median:5973.61 stddev:650.17 (10.9%) stddev-sans-first:614.93 08:50:22 INFO - PROCESS | 2194 | Values: 2994.5 3413.5 3422.5 3441.5 3488.9 5568.2 5674.9 5678.9 5699.8 5704.6 5620.5 5674.0 5749.0 5760.5 5763.9 5135.2 5182.6 5182.7 5186.7 5253.5 5119.3 5160.1 5212.7 5222.8 5267.6 5228.0 5229.7 5235.6 5250.6 5258.7 5223.5 5231.6 5233.2 5251.2 5309.8 5096.5 5113.0 5157.1 5172.4 5203.7 5635.3 5647.8 5722.9 5738.7 5740.3 6169.3 6231.1 6271.8 6280.9 6284.6 6360.1 6360.5 6376.1 6379.4 6381.5 5666.5 5673.8 5746.1 5815.9 5851.6 6255.8 6301.9 6309.7 6321.9 6333.4 6033.8 6222.3 6234.0 6241.2 6249.6 4984.3 6170.1 6235.2 6244.6 6271.2 6224.2 6246.5 6252.3 6258.2 6268.6 6233.0 6302.1 6302.6 6320.2 6323.4 4893.0 4933.1 4941.5 4958.2 5011.0 4390.5 4436.3 4457.4 4508.6 4512.8 5913.4 5914.4 5918.0 5944.3 5953.1 6102.6 6153.8 6228.8 6229.8 6246.8 5762.9 5829.7 5848.7 5907.1 5908.3 5433.6 5456.4 5457.0 5473.1 5502.2 6373.6 6379.5 6383.7 6413.9 6428.8 6011.0 6124.0 6200.8 6222.7 6232.3 6223.7 6227.2 6229.8 6324.5 6377.2 6188.5 6199.5 6213.8 6215.5 6217.1 6118.7 6186.7 6222.7 6223.9 6234.7 6096.3 6111.0 6124.0 6127.4 6187.2 6177.0 6183.8 6191.3 6201.2 6205.1 5001.6 5881.3 6043.2 6059.4 6112.6 5897.2 5955.6 6024.4 6063.5 6096.5 5965.0 5968.9 5973.6 5981.6 5989.6 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#1] ext.html Cycles:180 Average:67803.51 Median:21505.33 stddev:150486.29 (699.8%) stddev-sans-first:150823.67 08:50:22 INFO - PROCESS | 2194 | Values: 526.4 534.7 544.1 552.2 574.9 30519.5 32754.7 32767.5 42737.6 44309.0 43737.6 44232.8 44340.3 44394.8 44479.1 9462.2 9626.3 9630.0 9652.6 9686.8 9400.3 9527.9 9531.0 9535.5 9542.6 9496.4 9533.7 9539.7 9544.6 9577.5 9482.9 9519.7 9533.7 9538.2 9538.9 9524.3 9607.6 9610.6 9613.5 9615.0 40791.6 41123.4 41170.4 41270.0 41421.6 3155.3 3735.5 3951.9 3966.9 3966.9 29813.9 29902.0 29952.4 31149.1 31330.8 3150.9 3291.8 3314.0 3373.3 3448.3 488921.0 492751.0 495712.0 496631.0 498468.0 33602.7 33607.5 33690.0 64107.7 64730.0 35331.0 35470.8 35510.0 35553.0 35637.3 14673.6 14796.0 14858.0 14872.2 14875.6 12466.6 12526.4 12531.4 12540.2 12552.3 7845.6 7889.0 7936.8 7937.9 8045.9 3305.2 3312.1 3316.4 3324.3 3366.1 902.7 933.4 992.7 1010.6 1038.1 28272.9 29930.7 29987.0 30624.9 30832.7 989.8 1054.9 1055.8 1065.6 1099.9 15419.6 15536.5 15851.8 16057.4 16108.8 565244.0 652273.0 655957.0 656252.6 657297.0 59830.7 60382.1 60470.7 60536.7 60698.0 1281.9 1312.5 1313.6 1400.2 1416.3 29151.6 30451.4 30682.8 30769.0 31142.8 48520.5 49136.8 49653.8 50112.7 50216.0 543224.0 544288.0 544456.0 544854.0 545298.0 24434.6 25691.6 26009.9 27584.9 28074.0 44974.6 45262.5 45882.0 46442.8 46519.5 37081.8 37355.4 37414.9 37598.0 38690.6 38864.8 39058.8 40004.0 40186.6 40375.0 37075.0 37426.7 37499.8 37558.2 38055.0 33160.7 34091.8 35012.5 35056.9 35063.8 25571.7 25581.1 25784.6 25798.1 26149.9 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#2] jquery.html Cycles:180 Average:35462.26 Median:386.38 stddev:100187.92 (25929.9%) stddev-sans-first:100434.24 08:50:22 INFO - PROCESS | 2194 | Values: 328.7 365.1 381.4 391.3 414.1 17034.4 19899.7 21552.1 21752.8 21784.9 19767.9 19987.7 20509.8 20860.2 21052.6 5564.9 5577.3 5594.3 5606.3 5944.2 4232.7 5838.9 5925.4 5946.4 5952.2 4265.2 4438.6 4479.7 4482.3 6468.5 6462.5 6478.8 6485.2 6487.8 6489.5 5131.4 5394.3 5450.6 5478.8 5502.3 12895.1 13178.0 16206.4 21034.8 25910.9 2036.6 2294.7 2309.6 2324.6 2325.9 9939.3 10055.7 10371.4 11482.0 15482.9 1765.1 1774.6 1785.6 1855.9 1856.2 109769.9 126734.0 130012.0 130884.0 134358.0 11343.5 11696.6 11776.2 11787.9 12084.9 14986.6 14988.8 15033.2 15033.5 15084.6 8513.3 8649.3 8689.4 8733.5 8756.2 8559.9 8571.0 8576.5 8671.9 8723.0 4488.4 4586.5 4587.7 4595.3 4662.7 1626.7 1875.9 1913.4 1915.5 1941.2 901.1 912.1 949.5 963.4 985.1 20237.1 20975.0 21846.7 21959.0 22013.4 785.3 915.9 922.8 932.2 936.7 10961.2 11373.2 11450.9 11563.7 11587.5 535656.0 595907.0 602530.0 618146.0 626710.0 132942.0 134150.3 137486.0 139223.3 144094.3 961.3 969.5 996.6 998.4 998.6 18834.0 19273.3 19359.6 19539.1 19594.2 53990.5 54240.4 54808.2 56306.0 56680.7 78944.0 80155.0 82800.0 85389.0 86593.7 7253.6 7496.4 7548.4 8039.4 8529.1 9244.6 12655.5 13157.9 13600.4 13764.0 5485.9 8116.6 9890.2 11149.1 11669.3 10270.2 10445.5 11406.1 11654.5 11833.2 11483.7 11802.3 12051.6 12072.6 12206.2 7340.4 7602.3 7654.7 7750.1 8007.5 8804.4 9936.2 11443.9 11628.5 11906.5 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#3] mootools.html Cycles:180 Average:5373.90 Median:4896.64 stddev:2996.80 (61.2%) stddev-sans-first:2989.74 08:50:22 INFO - PROCESS | 2194 | Values: 1322.5 1366.8 1465.7 1594.5 1825.0 6689.5 7988.4 8198.3 8444.3 8455.8 8342.5 8385.2 8394.0 8407.4 8417.2 2367.7 2406.2 2408.3 2408.3 2408.4 2372.6 2421.2 2423.3 2430.4 2430.5 2077.6 2307.7 2315.4 2356.8 2381.5 2300.7 2324.1 2360.6 2365.6 2365.7 1973.9 2370.8 2393.0 2394.4 2396.1 7634.3 7803.8 8267.4 8328.5 8426.2 5023.7 5064.2 5184.1 5187.5 5188.9 3351.5 3510.4 3605.0 3615.6 3624.7 1080.1 1093.2 1098.5 1122.0 1128.3 9145.3 11051.9 11132.3 11142.4 11170.0 4312.2 4451.0 4510.7 4544.0 4545.5 8650.7 8659.5 8667.2 8693.0 8702.2 5108.3 5115.4 5119.5 5120.9 5137.8 3737.1 4257.8 4301.2 4350.5 4745.2 3526.2 3694.9 3794.3 3801.3 3821.7 997.7 1134.4 1147.4 1149.4 1163.2 726.8 749.8 777.8 845.2 892.9 5293.6 5334.4 5480.6 5519.2 5554.1 416.7 416.9 418.2 424.6 430.7 3314.7 3410.1 3593.6 3668.6 3814.7 9953.4 10286.7 10415.5 10432.6 10455.7 10377.4 10379.3 10389.5 10399.7 10438.8 7771.8 7774.1 7838.2 7884.6 7937.2 5274.0 5299.7 5436.9 5539.7 5612.0 9492.1 9530.0 9537.4 9558.6 9559.7 7512.6 8796.5 9076.5 9502.4 9503.0 6733.0 7028.1 7150.6 7192.4 7293.6 7770.8 7871.8 7955.8 8065.0 8070.7 5579.5 7069.4 7154.1 7254.6 7278.6 7022.9 7028.7 7048.3 7077.5 7137.3 6523.0 6712.7 6721.6 6811.1 6824.6 4605.9 4707.0 4718.8 4831.7 4927.6 4758.5 4798.3 4824.4 4842.1 4865.7 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#4] prototype.html Cycles:180 Average:4314.32 Median:4767.68 stddev:1316.32 (27.6%) stddev-sans-first:1285.22 08:50:22 INFO - PROCESS | 2194 | Values: 308.9 309.9 317.2 319.8 323.2 5170.9 5171.5 5270.3 5292.6 5302.5 4045.8 4838.4 4922.8 5176.5 5204.3 3588.9 3624.9 3655.9 3787.4 3890.5 3733.6 3738.7 3951.9 3974.1 3978.7 3526.9 3726.4 3795.3 3987.2 4003.0 3210.0 3555.9 3782.5 3949.3 3964.8 3086.8 3432.5 3441.4 3449.3 3461.8 4538.6 4547.2 4819.3 4926.7 5116.0 3722.7 4319.6 4396.4 4507.2 4572.0 5453.3 5474.9 5475.9 5484.9 5493.9 3430.9 3855.4 3869.1 3889.0 3901.5 5057.2 5192.4 5481.6 5493.6 5816.2 3390.2 3776.9 3881.2 3908.8 3921.5 3471.9 3702.1 3974.8 3983.2 3991.6 3652.8 4357.9 4392.6 4587.3 4607.2 4667.4 5155.6 5463.9 5495.0 5505.8 1147.9 1286.5 1291.4 1295.5 1301.7 841.0 852.6 873.2 874.7 891.7 4232.5 4441.9 4803.5 4814.1 5278.0 5348.9 5355.9 5673.5 5674.6 5704.1 4862.7 5236.7 5262.3 5341.7 5351.6 2469.6 2654.3 2656.2 2787.8 2791.5 4546.3 5137.1 5520.4 5530.5 5586.8 4710.8 4897.9 5404.0 5517.7 5575.9 4721.4 4795.7 4950.4 5600.4 5693.8 4991.3 5414.3 5458.4 5471.6 5489.2 4454.7 5251.5 5263.7 5266.5 5369.9 4322.8 4459.6 4629.5 5515.4 5594.2 3088.4 3254.9 3608.0 3665.7 3675.9 4731.3 4734.6 4739.7 5403.8 5459.9 4430.5 4646.0 5002.3 5092.6 5299.3 4892.6 5159.3 5174.4 5191.3 5316.3 4420.2 4490.9 4716.8 5418.0 5471.5 5054.3 5341.4 5428.9 5456.9 5512.9 5390.6 5420.6 5439.6 5441.0 5471.3 08:50:22 INFO - PROCESS | 2194 | 08:50:22 INFO - PROCESS | 2194 | [#5] yui.html Cycles:180 Average:20299.96 Median:4445.30 stddev:30059.27 (676.2%) stddev-sans-first:30107.54 08:50:22 INFO - PROCESS | 2194 | Values: 693.2 701.8 715.8 722.2 755.7 14437.9 15332.3 15341.2 15347.8 15366.8 13672.9 13803.2 13812.4 13829.4 13837.1 697.6 717.9 840.4 850.5 856.2 864.9 869.2 879.0 880.2 885.3 941.3 942.6 944.3 945.6 945.6 930.2 933.0 933.3 933.7 935.7 680.7 685.2 688.2 690.1 690.9 12697.0 14526.9 14855.9 14945.8 14966.9 14342.6 14616.3 14635.8 14659.9 14804.7 10916.8 11213.6 11248.6 11688.5 11734.4 4488.5 4517.4 4694.4 4728.3 4735.3 90808.0 94083.0 94778.0 94921.0 95160.0 10434.2 10697.7 10712.4 10742.4 10850.3 19394.3 19417.0 19549.8 19618.2 19650.8 7528.0 7609.6 7666.7 7700.0 7826.2 4238.0 4319.2 4335.2 4402.1 4490.2 3115.4 3173.3 3185.6 3223.4 3254.0 635.9 639.5 642.9 649.1 653.7 535.9 557.6 568.2 601.9 620.5 7658.4 8291.9 8488.5 8555.8 8682.3 559.3 579.0 598.6 611.0 625.4 4158.9 4220.7 4236.7 4246.2 4323.3 112359.4 114285.4 119258.4 119551.0 119998.0 64084.0 65506.7 67300.3 82340.6 104073.0 89807.6 91607.6 92573.1 93911.1 95547.5 7110.3 7906.8 8190.6 8262.0 8365.5 34974.0 51122.5 51517.5 51545.7 59816.4 52429.5 57251.7 72452.0 75309.0 76325.6 10885.3 11202.2 11234.3 11619.7 11698.9 13703.0 14150.4 14210.6 14966.9 14990.4 12936.1 13476.0 13533.8 13744.7 13910.5 12468.7 12725.0 12921.2 13291.0 13854.4 12491.4 12786.6 13033.1 13360.7 13729.0 10215.7 10676.5 10962.5 10997.5 11048.8 10754.0 10877.4 11037.1 11151.1 11191.4 08:50:22 INFO - PROCESS | 2194 | -------- Summary: end -------- 08:50:22 INFO - PROCESS | 2194 | 08:50:23 INFO - TEST-INFO | 2194: exit 0 08:50:23 INFO - TEST-OK | dromaeo_css | took 1117729ms 08:50:23 INFO - TEST-START | kraken 08:50:23 INFO - operating with platform_type : mac_ 08:50:23 INFO - Initialising browser for kraken test... 08:50:23 INFO - TEST-INFO | started process 2196 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpGYFBWk/profile http://localhost:57422/getInfo.html) 08:50:25 INFO - PROCESS | 2196 | __metrics Screen width/height:1600/1200 08:50:25 INFO - PROCESS | 2196 | colorDepth:24 08:50:25 INFO - PROCESS | 2196 | Browser inner width/height: 1024/689 08:50:25 INFO - PROCESS | 2196 | __metrics 08:50:25 INFO - PROCESS | 2196 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:50:25 INFO - PROCESS | 2196 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:26 INFO - TEST-INFO | 2196: exit 0 08:50:26 INFO - Browser initialized. 08:50:26 INFO - Running cycle 1/1 for kraken test... 08:50:26 INFO - TEST-INFO | started process 2198 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpGYFBWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:38 INFO - PROCESS | 2198 | RSS: Main: 167690240 08:50:38 INFO - PROCESS | 2198 | 08:50:41 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57422/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:42 INFO - PROCESS | 2198 | RSS: Main: 218193920 08:50:42 INFO - PROCESS | 2198 | 08:50:44 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57422/tests/kraken/driver.html?testName=audio-dft) 08:50:45 INFO - PROCESS | 2198 | RSS: Main: 231743488 08:50:45 INFO - PROCESS | 2198 | 08:50:48 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57422/tests/kraken/driver.html?testName=audio-fft) 08:50:49 INFO - PROCESS | 2198 | RSS: Main: 329105408 08:50:49 INFO - PROCESS | 2198 | 08:50:51 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57422/tests/kraken/driver.html?testName=audio-oscillator) 08:50:51 INFO - PROCESS | 2198 | RSS: Main: 232755200 08:50:51 INFO - PROCESS | 2198 | 08:50:53 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57422/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:50:54 INFO - PROCESS | 2198 | RSS: Main: 233672704 08:50:54 INFO - PROCESS | 2198 | 08:50:57 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57422/tests/kraken/driver.html?testName=imaging-darkroom) 08:50:57 INFO - PROCESS | 2198 | RSS: Main: 273465344 08:50:57 INFO - PROCESS | 2198 | 08:51:00 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57422/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:01 INFO - PROCESS | 2198 | RSS: Main: 273506304 08:51:01 INFO - PROCESS | 2198 | 08:51:03 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57422/tests/kraken/driver.html?testName=json-parse-financial) 08:51:04 INFO - PROCESS | 2198 | RSS: Main: 272547840 08:51:04 INFO - PROCESS | 2198 | 08:51:06 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57422/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:06 INFO - PROCESS | 2198 | RSS: Main: 248430592 08:51:06 INFO - PROCESS | 2198 | 08:51:08 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:09 INFO - PROCESS | 2198 | RSS: Main: 247332864 08:51:09 INFO - PROCESS | 2198 | 08:51:11 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:11 INFO - PROCESS | 2198 | RSS: Main: 250568704 08:51:11 INFO - PROCESS | 2198 | 08:51:14 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:15 INFO - PROCESS | 2198 | RSS: Main: 269221888 08:51:15 INFO - PROCESS | 2198 | 08:51:18 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:19 INFO - PROCESS | 2198 | RSS: Main: 262762496 08:51:19 INFO - PROCESS | 2198 | 08:51:20 INFO - PROCESS | 2198 | Cycle 1(1): loaded http://localhost:57422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57422/tests/kraken/driver.html?testName=ai-astar) 08:51:20 INFO - PROCESS | 2198 | RSS: Main: 306692096 08:51:20 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | __start_tp_report 08:51:21 INFO - PROCESS | 2198 | _x_x_mozilla_page_load 08:51:21 INFO - PROCESS | 2198 | _x_x_mozilla_page_load_details 08:51:21 INFO - PROCESS | 2198 | |i|pagename|runs| 08:51:21 INFO - PROCESS | 2198 | |0;ai-astar;103;115;116;114;114;113;114;114;114;120 08:51:21 INFO - PROCESS | 2198 | |1;audio-beat-detection;153;140;92;162;139;139;96;135;174;137 08:51:21 INFO - PROCESS | 2198 | |2;audio-dft;185;185;184;185;183;182;182;183;185;182 08:51:21 INFO - PROCESS | 2198 | |3;audio-fft;82;58;59;88;58;59;58;59;82;58 08:51:21 INFO - PROCESS | 2198 | |4;audio-oscillator;84;69;92;69;67;70;87;66;68;89 08:51:21 INFO - PROCESS | 2198 | |5;imaging-gaussian-blur;89;85;89;87;90;86;90;86;87;86 08:51:21 INFO - PROCESS | 2198 | |6;imaging-darkroom;94;95;94;100;96;94;94;94;95;94 08:51:21 INFO - PROCESS | 2198 | |7;imaging-desaturate;85;85;79;88;80;80;84;85;83;83 08:51:21 INFO - PROCESS | 2198 | |8;json-parse-financial;56;54;53;55;56;56;58;56;59;57 08:51:21 INFO - PROCESS | 2198 | |9;json-stringify-tinderbox;63;65;80;77;66;69;68;70;69;70 08:51:21 INFO - PROCESS | 2198 | |10;stanford-crypto-aes;81;81;80;83;82;81;82;81;82;83 08:51:21 INFO - PROCESS | 2198 | |11;stanford-crypto-ccm;144;123;143;143;151;154;130;154;185;125 08:51:21 INFO - PROCESS | 2198 | |12;stanford-crypto-pbkdf2;186;225;197;165;161;163;160;161;161;159 08:51:21 INFO - PROCESS | 2198 | |13;stanford-crypto-sha256-iterative;65;67;66;66;65;65;66;65;65;65 08:51:21 INFO - PROCESS | 2198 | __end_tp_report 08:51:21 INFO - PROCESS | 2198 | __start_cc_report 08:51:21 INFO - PROCESS | 2198 | _x_x_mozilla_cycle_collect,1946 08:51:21 INFO - PROCESS | 2198 | __end_cc_report 08:51:21 INFO - PROCESS | 2198 | __startTimestamp1487004680999__endTimestamp 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | ------- Summary: start ------- 08:51:21 INFO - PROCESS | 2198 | Number of tests: 14 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:4.24 (3.7%) stddev-sans-first:2.09 08:51:21 INFO - PROCESS | 2198 | Values: 103.0 115.0 116.0 114.0 114.0 113.0 114.0 114.0 114.0 120.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:157.50 stddev:25.77 (16.4%) stddev-sans-first:26.65 08:51:21 INFO - PROCESS | 2198 | Values: 153.0 140.0 92.0 162.0 139.0 139.0 96.0 135.0 174.0 137.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:1.35 (0.7%) stddev-sans-first:1.33 08:51:21 INFO - PROCESS | 2198 | Values: 185.0 185.0 184.0 185.0 183.0 182.0 182.0 183.0 185.0 182.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#3] audio-fft Cycles:10 Average:66.10 Median:59.00 stddev:12.47 (21.1%) stddev-sans-first:11.82 08:51:21 INFO - PROCESS | 2198 | Values: 82.0 58.0 59.0 88.0 58.0 59.0 58.0 59.0 82.0 58.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.00 stddev:10.48 (13.6%) stddev-sans-first:10.72 08:51:21 INFO - PROCESS | 2198 | Values: 84.0 69.0 92.0 69.0 67.0 70.0 87.0 66.0 68.0 89.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:1.84 (2.1%) stddev-sans-first:1.87 08:51:21 INFO - PROCESS | 2198 | Values: 89.0 85.0 89.0 87.0 90.0 86.0 90.0 86.0 87.0 86.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:94.00 stddev:1.89 (2.0%) stddev-sans-first:1.96 08:51:21 INFO - PROCESS | 2198 | Values: 94.0 95.0 94.0 100.0 96.0 94.0 94.0 94.0 95.0 94.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#7] imaging-desaturate Cycles:10 Average:83.20 Median:84.50 stddev:2.82 (3.3%) stddev-sans-first:2.92 08:51:21 INFO - PROCESS | 2198 | Values: 85.0 85.0 79.0 88.0 80.0 80.0 84.0 85.0 83.0 83.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.76 (3.1%) stddev-sans-first:1.87 08:51:21 INFO - PROCESS | 2198 | Values: 56.0 54.0 53.0 55.0 56.0 56.0 58.0 56.0 59.0 57.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:5.21 (7.5%) stddev-sans-first:4.93 08:51:21 INFO - PROCESS | 2198 | Values: 63.0 65.0 80.0 77.0 66.0 69.0 68.0 70.0 69.0 70.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 08:51:21 INFO - PROCESS | 2198 | Values: 81.0 81.0 80.0 83.0 82.0 81.0 82.0 81.0 82.0 83.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:147.50 stddev:18.00 (12.2%) stddev-sans-first:19.09 08:51:21 INFO - PROCESS | 2198 | Values: 144.0 123.0 143.0 143.0 151.0 154.0 130.0 154.0 185.0 125.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:164.00 stddev:22.12 (13.5%) stddev-sans-first:23.02 08:51:21 INFO - PROCESS | 2198 | Values: 186.0 225.0 197.0 165.0 161.0 163.0 160.0 161.0 161.0 159.0 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - PROCESS | 2198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 08:51:21 INFO - PROCESS | 2198 | Values: 65.0 67.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 08:51:21 INFO - PROCESS | 2198 | -------- Summary: end -------- 08:51:21 INFO - PROCESS | 2198 | 08:51:21 INFO - TEST-INFO | 2198: exit 0 08:51:22 INFO - TEST-OK | kraken | took 58719ms 08:51:22 INFO - SUITE-END | took 1176s 08:51:22 INFO - Completed test suite (00:19:36) 08:51:22 INFO - javascript benchmark 08:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.5059065254236, 3413.4709120086386, 3422.5454181972673, 3441.518187453755, 3488.9476657850137, 5568.16477528371, 5674.943250567493, 5678.943210567893, 5699.829005129843, 5704.600677952545, 5620.522255608278, 5674.0, 5748.971255143719, 5760.510356619682, 5763.942360576393, 5135.229715542661, 5182.637215394924, 5182.714950677711, 5186.7147306898105, 5253.50091741284, 5119.283300337956, 5160.096983027974, 5212.6611770235, 5222.843314700565, 5267.578593712513, 5228.006678731029, 5229.738513074331, 5235.581153507729, 5250.553702935255, 5258.710770907599, 5223.477652234784, 5231.607629427808, 5233.241180028913, 5251.159814429711, 5309.787608495655, 5096.490350964911, 5113.0, 5157.097507936096, 5172.431032586413, 5203.713795741232, 5635.267415236034, 5647.774089036475, 5722.914156287659, 5738.741756620962, 5740.253767010304, 6169.290531588835, 6231.127642130105, 6271.78048768291, 6280.87438251237, 6284.5600807943465, 6360.109584658151, 6360.491160707133, 6376.139221205124, 6379.362063793584, 6381.521385896076, 5666.5183459406, 5673.773049078032, 5746.109353050284, 5815.912761308584, 5851.619644723164, 6255.80026144834, 6301.936980630227, 6309.747610095636, 6321.936780632135, 6333.366663333722, 6033.7586496540525, 6222.346653601307, 6234.0, 6241.157443745127, 6249.562530622813, 4984.27727979441, 6170.10533472644, 6235.220597425322, 6244.625322480666, 6271.184745982993, 6224.221972253468, 6246.531510136667, 6252.280987686383, 6258.186435763413, 6268.561200715906, 6233.0338797486465, 6302.1177035215105, 6302.621842689453, 6320.178376811077, 6323.399277068763, 4893.0, 4933.062718083553, 4941.530554597308, 4958.157113290749, 5011.022850544182, 4390.4511936008, 4436.3123715824095, 4457.375967364572, 4508.616767574727, 4512.796924138422, 5913.379095195029, 5914.408559144051, 5918.0, 5944.256967879015, 5953.1070339449425, 6102.633841969496, 6153.784617538365, 6228.813135605939, 6229.813105606839, 6246.843828904313, 5762.9135562966585, 5829.679367634821, 5848.736806843703, 5907.054871220584, 5908.261467316585, 5433.6196466247775, 5456.372517160498, 5457.045017122067, 5473.0969390051, 5502.202180683778, 6373.617582945131, 6379.457746091634, 6383.680815959091, 6413.935860641333, 6428.839279018062, 6010.969945150421, 6124.0, 6200.782972595937, 6222.688865556614, 6232.314445411092, 6223.657698826608, 6227.19046523949, 6229.813105606839, 6324.525660575383, 6377.202849643794, 6188.4739797117745, 6199.535034872493, 6213.782517611862, 6215.533834962305, 6217.067439883873, 6118.741008805849, 6186.690665466798, 6222.719977600928, 6223.875522489434, 6234.688265586612, 6096.329403765493, 6110.961136606877, 6124.0, 6127.356627554221, 6187.1647327612, 6177.0, 6183.752649893954, 6191.349908259568, 6201.193844800147, 6205.131281620667, 5001.624878134082, 5881.264841894763, 6043.153958445909, 6059.424354686298, 6112.572119951561, 5897.203877476657, 5955.553333499918, 6024.367441418588, 6063.5452341073715, 6096.542759292982, 5964.97017514927, 5968.880622387441, 5973.611715238496, 5981.611195272293, 5989.64062156272], "value": 5717.186703175471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.4183077699142, 534.6978956889359, 544.1266766839223, 552.2241251042284, 574.8936446757352, 30519.542206866914, 32754.67245327546, 32767.50848737271, 42737.57262427375, 44309.0, 43737.56262437375, 44232.778836105776, 44340.33489497652, 44394.77802610982, 44479.11041779163, 9462.243020558357, 9626.278029147807, 9630.0, 9652.565634546427, 9686.806263874718, 9400.294977876652, 9527.857082143773, 9531.0, 9535.523223838814, 9542.570584323686, 9496.43021418717, 9533.666321678742, 9539.666111686092, 9544.568314752772, 9577.521123943776, 9482.857757133614, 9519.666811661558, 9533.666321678707, 9538.236941044734, 9538.904610953941, 9524.285678574135, 9607.615695372177, 9610.567524461416, 9613.51932403377, 9614.990426005239, 40791.59208407937, 41123.38314925278, 41170.38244426336, 41270.0, 41421.58578414207, 3155.2900597365638, 3735.4583585380237, 3951.8616848410165, 3966.880993570169, 3966.920661586752, 29813.850930745426, 29902.0, 29952.400951981057, 31149.065528034196, 31330.843345783127, 3150.9054728358187, 3291.8024918504725, 3313.96686033139, 3373.3084717633074, 3448.3103379324234, 488921.0, 492751.0, 495712.0, 496631.0, 498468.0, 33602.66397336044, 33607.49588756171, 33689.98930032103, 64107.67946160239, 64730.0, 35331.0, 35470.822645886605, 35510.0, 35553.0, 35637.28725425477, 14673.559793206221, 14795.964282500121, 14858.0, 14872.182029988238, 14875.628109297355, 12466.563670271496, 12526.436310366056, 12531.43608537618, 12540.24758514492, 12552.309622970643, 7845.607719613997, 7888.974433323746, 7936.841263174704, 7937.880931786028, 8045.879311810328, 3305.2397948471985, 3312.0560640217423, 3316.369889720945, 3324.335132973415, 3366.1248075500057, 902.6882253744747, 933.3979583168954, 992.712113487095, 1010.5755582655303, 1038.0605551975323, 28272.8586357071, 29930.70069299323, 29987.0, 30624.92812751543, 30832.691673082983, 989.8020395920845, 1054.8945105489543, 1055.7941201465794, 1065.6270305393205, 1099.8570185875785, 15419.61450963735, 15536.456224032105, 15851.841481585267, 16057.357705691642, 16108.812649669697, 565244.0426787203, 652273.0, 655957.0, 656252.5936851617, 657297.0, 59830.70084649549, 60382.09426858601, 60470.697646511486, 60536.697316513135, 60698.0, 1281.8910392616733, 1312.4815697799315, 1313.6453157647572, 1400.1948879394592, 1416.2706206303762, 29151.562726558695, 30451.390972180874, 30682.84658576693, 30769.0, 31142.844285778425, 48520.514794853014, 49136.75431622819, 49653.751731241115, 50112.74943625258, 50216.0, 543224.0, 544288.0, 544456.0, 544854.0, 545298.0, 24434.633480498163, 25691.614625780254, 26009.869950650882, 27584.862075690296, 28074.0, 44974.55025449704, 45262.54737452715, 45882.0, 46442.76778616221, 46519.53480465152, 37081.81459092687, 37355.439668404455, 37414.94217818046, 37598.0, 38690.613093869826, 38864.80567597144, 39058.80470597629, 40004.0, 40186.598134019456, 40375.0, 37075.0, 37426.690065847564, 37499.81250093732, 37558.2488350226, 38055.0, 33160.668393315755, 34091.82954085214, 35012.47481287834, 35056.94829155129, 35063.82468087643, 25571.74428255768, 25581.104661336765, 25784.613230801177, 25798.09706660258, 26149.869250653624], "value": 18636.64659230662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.723871947564, 365.1218818740927, 381.4392842521494, 391.31910475772145, 414.1179288116312, 17034.403795867147, 19899.701504477445, 21552.137914483403, 21752.782472175273, 21784.8910755446, 19767.901160494177, 19987.700184497244, 20509.794902050977, 20860.165593376245, 21052.57894842102, 5564.916526252109, 5577.3028371453565, 5594.342687223577, 5606.299212598426, 5944.197533332988, 4232.74603523788, 5838.9124163137585, 5925.377835327272, 5946.43508866657, 5952.166696662471, 4265.210935976838, 4438.556144385568, 4479.686421950465, 4482.282834746441, 6468.4825213983, 6462.5153113516435, 6478.773242936474, 6485.221773387177, 6487.83780405489, 6489.48084153269, 5131.4098878629065, 5394.32570928634, 5450.591205659552, 5478.808241711561, 5502.339719233678, 12895.09734318598, 13178.0, 16206.35174593015, 21034.78965210359, 25910.87044564765, 2036.5825005873908, 2294.66727324537, 2309.58427483053, 2324.6164382876805, 2325.860448373103, 9939.304248702594, 10055.748606284827, 10371.429571373572, 11482.024027957634, 15482.922585387001, 1765.0997991024542, 1774.6361995790833, 1785.61609254011, 1855.879367841086, 1856.1740025688573, 109769.90230097677, 126734.0, 130012.04981925279, 130884.0, 134357.98463022965, 11343.489542970587, 11696.590619328283, 11776.17566770335, 11787.880151385605, 12084.885953726516, 14986.625334366729, 14988.775168372484, 15033.173175475235, 15033.548993530212, 15084.622884427758, 8513.318934485227, 8649.308055355556, 8689.391742577958, 8733.51965641883, 8756.168164024408, 8559.871601925975, 8571.0, 8576.528290944058, 8671.913280867237, 8722.956385218033, 4488.3940668010055, 4586.495485496593, 4587.72473651582, 4595.264399390833, 4662.673612847136, 1626.725916521205, 1875.8874467531991, 1913.425972208332, 1915.4828196386898, 1941.1555973151724, 901.1112380592795, 912.1289168843738, 949.539473355422, 963.3930623707159, 985.0641890204334, 20237.08933097985, 20975.0, 21846.680873947054, 21959.0, 22013.449663758212, 785.3010820369875, 915.949622770754, 922.820050090226, 932.2076235200026, 936.7002559181133, 10961.232713710124, 11373.221532049798, 11450.885491144982, 11563.6530904073, 11587.478563464665, 535656.0, 595907.0, 602530.0, 618146.0, 626710.0, 132942.0, 134150.3292483551, 137486.0, 139223.30388348197, 144094.27952860168, 961.3078583419926, 969.5346233807671, 996.5764550066193, 998.3510718033336, 998.5656239535825, 18834.0, 19273.325433610316, 19359.612807744048, 19539.120739566468, 19594.216231350587, 53990.46009539854, 54240.3727888164, 54808.17787733107, 56306.0, 56680.71659641675, 78944.0, 80155.0, 82800.0, 85389.0, 86593.70109448489, 7253.601051941982, 7496.437767167376, 7548.358389536731, 8039.437239393186, 8529.104444033535, 9244.630214791334, 12655.493780248687, 13157.868421315665, 13600.387982540611, 13764.0, 5485.930243602459, 8116.553589552631, 9890.208783297463, 11149.108071354434, 11669.299842009506, 10270.178385729274, 10445.477726113815, 11406.14453915943, 11654.475548600163, 11833.171677982458, 11483.712907177387, 11802.291862488279, 12051.638450846489, 12072.637820865388, 12206.206596571194, 7340.449466290156, 7602.277783610548, 7654.655540500802, 7750.0699916010435, 8007.519548827089, 8804.427712198687, 9936.20510359155, 11443.942780286045, 11628.53485860556, 11906.523739050688], "value": 9475.096253287831, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.5371120107961, 1366.7835626292594, 1465.7361674898518, 1594.5216435069476, 1825.0053720722196, 6689.531732778707, 7988.36093112551, 8198.262156405923, 8444.324454043677, 8455.788605284872, 8342.499450033003, 8385.203405676466, 8394.0, 8407.369447291447, 8417.158284171579, 2367.6566897799853, 2406.1578447543393, 2408.2534414331612, 2408.277516744978, 2408.4460574067975, 2372.620380739082, 2421.225207933462, 2423.3456966619, 2430.3802530354733, 2430.5260474207535, 2077.5844831033855, 2307.711536057993, 2315.444293369596, 2356.8350215484925, 2381.452265978826, 2300.66640337151, 2324.1284518305633, 2360.5514952159033, 2365.5860224460653, 2365.680633114525, 1973.9309124180584, 2370.767201055459, 2392.964105538418, 2394.4133687246563, 2396.1493669747165, 7634.274743899321, 7803.790412486017, 8267.379946503976, 8328.541930193836, 8426.241638252526, 5023.673461225008, 5064.215046667772, 5184.11869982104, 5187.455317191716, 5188.948110518884, 3351.497275408708, 3510.403231450634, 3604.981975090134, 3615.6384361563896, 3624.691901188402, 1080.1089101491223, 1093.2347356850157, 1098.5166526728215, 1121.9719507012308, 1128.2609890521721, 9145.314101442418, 11051.889481105167, 11132.276402033924, 11142.442877856074, 11170.0, 4312.180685669713, 4450.977745111254, 4510.7068040577915, 4544.0457503924545, 4545.477270113913, 8650.6972255972, 8659.52372619512, 8667.219950204511, 8692.95653521741, 8702.173293537104, 5108.3103780989095, 5115.360579927509, 5119.462456442095, 5120.948790512047, 5137.8201762938115, 3737.1404576947452, 4257.829686812554, 4301.204277208726, 4350.499692535335, 4745.240761478216, 3526.171349732862, 3694.852205911787, 3794.2601192767697, 3801.3157631626573, 3821.7133714971487, 997.7006897930592, 1134.4214450630238, 1147.437755499799, 1149.36210403227, 1163.2322667039714, 726.8364617960916, 749.79380670315, 777.766669998998, 845.2097289034772, 892.8705337726124, 5293.609757549946, 5334.359876814729, 5480.6437581557075, 5519.199716041152, 5554.08357620988, 416.6500139882453, 416.91870085333676, 418.15323968963094, 424.6496640271788, 430.6597787747707, 3314.734821214297, 3410.1474631342167, 3593.6047034826147, 3668.5781135169796, 3814.6948244140403, 9953.402795832273, 10286.742831429125, 10415.479226038668, 10432.634857779942, 10455.738606534898, 10377.429241391796, 10379.325343852626, 10389.53247103867, 10399.688009359732, 10438.843417348746, 7771.805704857424, 7774.067111946602, 7838.216178382117, 7884.605769711607, 7937.166597507178, 5273.973630131978, 5299.655522391032, 5436.937586023644, 5539.667619942817, 5612.045952188219, 9492.145706886413, 9529.952350238482, 9537.380070295409, 9558.56986435598, 9559.713208603753, 7512.624368781429, 8796.516191609522, 9076.455412675261, 9502.429854208769, 9503.0, 6732.9663351684885, 7028.0863487746265, 7150.570965741864, 7192.388646965067, 7293.598852063187, 7770.844583108419, 7871.803204919694, 7955.761327160194, 8065.0, 8070.677172913018, 5579.525740311957, 7069.363757261871, 7154.141503019671, 7254.5647261164495, 7278.599677017814, 7022.894656580258, 7028.718851245892, 7048.259932706992, 7077.469189810682, 7137.250588688113, 6522.967385163044, 6712.6979285931275, 6721.596704197764, 6811.114555107804, 6824.556403833735, 4605.884852878705, 4706.958068715962, 4718.787654555622, 4831.685940413862, 4927.60579153674, 4758.4765675776325, 4798.2802579613335, 4824.445188803333, 4842.055799119138, 4865.683730557503], "value": 4264.887145297039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.92431354318194, 309.90392978176754, 317.1563640715695, 319.8464736926275, 323.2210373001068, 5170.896582068361, 5171.508706672865, 5270.288511051007, 5292.576593872491, 5302.522772950443, 4045.817938192781, 4838.371011768465, 4922.778474968626, 5176.456472070435, 5204.32343795307, 3588.910277243077, 3624.87312944047, 3655.8903232903053, 3787.367779393323, 3890.533136023681, 3733.589305176442, 3738.738288319819, 3951.940720889189, 3974.1256923476935, 3978.7413818101877, 3526.9294614107703, 3726.441033844918, 3795.259924314746, 3987.182627561343, 4002.9799851000703, 3209.9839500802464, 3555.9466608000903, 3782.508273924386, 3949.269385163754, 3964.762114273124, 3086.8302243376606, 3432.4508078707286, 3441.397755392796, 3449.3273811606746, 3461.809600471973, 4538.636909047268, 4547.226971414867, 4819.349387832633, 4926.729029903354, 5116.0, 3722.7207959403154, 4319.568043195687, 4396.428464299621, 4507.166174257773, 4571.9542804571865, 5453.291072160594, 5474.863128421782, 5475.863103422406, 5484.890302193974, 5493.945060549383, 3430.8627654893776, 3855.4409610606303, 3869.129445874684, 3889.0, 3901.453796468497, 5057.241413787924, 5192.417232109832, 5481.561475081984, 5493.560515158778, 5816.243888294494, 3390.2371966307383, 3776.9046976376544, 3881.1849511602313, 3908.765474071508, 3921.450996860442, 3471.94792078119, 3702.1114932416563, 3974.8201438848805, 3983.223271462095, 3991.6270751215175, 3652.7625704329134, 4357.888738371695, 4392.604665580113, 4587.334836448763, 4607.193741095362, 4667.439907211156, 5155.576878866927, 5463.945360546423, 5494.955958367897, 5505.752241149158, 1147.8737338892715, 1286.4854058376536, 1291.3607764156802, 1295.475332490343, 1301.7201301720177, 840.995795021021, 852.6418904060309, 873.2097451806126, 874.7157173918501, 891.7458524320538, 4232.4551538688775, 4441.911161776747, 4803.543663351976, 4814.109389762905, 5278.0, 5348.946510534923, 5355.928814237168, 5673.461021202979, 5674.574406919498, 5704.0588302929555, 4862.708237505761, 5236.73816309183, 5262.342207224097, 5341.732913354317, 5351.565037907742, 2469.6295555666793, 2654.2568080937367, 2656.2031390582747, 2787.76304014157, 2791.5114854900717, 4546.317862390871, 5137.099273268915, 5520.3651580068, 5530.511269928548, 5586.804461843816, 4710.81156753726, 4897.926531102036, 5403.972980135153, 5517.675757818095, 5575.944240557543, 4721.386219791405, 4795.688280261772, 4950.356453661073, 5600.411956744565, 5693.800716974886, 4991.276264941635, 5414.3232095988005, 5458.426865179258, 5471.616986811045, 5489.231507589021, 4454.665900057574, 5251.531780063364, 5263.710495922761, 5266.473352664703, 5369.919451208157, 4322.78386080701, 4459.550646039985, 4629.537046295343, 5515.393306736336, 5594.1608758686525, 3088.351446196234, 3254.8535315910367, 3608.0, 3665.7067434604633, 3675.852965881335, 4731.337612734289, 4734.621230301636, 4739.668223224341, 5403.811751066889, 5459.890802184013, 4430.512643609136, 4645.953540464552, 5002.274670172732, 5092.567131793691, 5299.284596579412, 4892.608591312757, 5159.303494028258, 5174.430812610534, 5191.338771593205, 5316.272211531191, 4420.237351655215, 4490.944628012479, 4716.834910778106, 5417.972910135424, 5471.50756431923, 5054.3176671150395, 5341.439148889311, 5428.945710542844, 5456.890862182813, 5512.862178445571, 5390.595705322038, 5420.620556561161, 5439.646422982493, 5440.972795136157, 5471.316085489314], "value": 3904.3174014667266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.2409012131715, 701.771924124659, 715.7938872998994, 722.2380388689934, 755.7128291249325, 14437.855621443783, 15332.310046047927, 15341.156236406992, 15347.769783453243, 15366.846331536695, 13672.931635341809, 13803.2408217548, 13812.447502099903, 13829.377678004488, 13837.100588461743, 697.5849369625065, 717.9102612173479, 840.3907167303717, 850.5492089192707, 856.2251162697753, 864.892937040589, 869.1829680100717, 878.9516576588285, 880.2254016465502, 885.3006125161115, 941.2846236860001, 942.6182396129578, 944.3059351376733, 945.6028468043404, 945.6264775413707, 930.1535602601667, 933.0296491648711, 933.3140141995627, 933.7105497295826, 935.6584846530967, 680.6766785776766, 685.1880521581942, 688.1845013658831, 690.1097584116484, 690.9274526174729, 12697.0, 14526.927365363106, 14855.851441485554, 14945.775813362809, 14966.925165374103, 14342.641433964234, 14616.26918654063, 14635.780463293058, 14659.926700366537, 14804.70390592193, 10916.836247456295, 11213.551457941672, 11248.606298779503, 11688.532458701642, 11734.354610496419, 4488.4613846338325, 4517.435320584927, 4694.413198350207, 4728.267118596623, 4735.337052812609, 90808.0, 94082.99999999932, 94778.0, 94921.0, 95160.0, 10434.217433692504, 10697.732556685989, 10712.35725856451, 10742.355458672504, 10850.348979061124, 19394.321198757974, 19417.0, 19549.804501955085, 19618.21527138927, 19650.803491965184, 7527.962360188164, 7609.581473019037, 7666.693332266758, 7699.961500192463, 7826.178251283533, 4237.978810105991, 4319.200947824663, 4335.197988372098, 4402.141582391467, 4490.236659767847, 3115.4392209402527, 3173.286010647586, 3185.617725872864, 3223.435898717762, 3254.0, 635.920509936258, 639.4596565901805, 642.877853207889, 649.0815496073099, 653.7025653327725, 535.8610921265087, 557.6486813307671, 568.196002656245, 601.885641728079, 620.4973971083436, 7658.425618078555, 8291.908621813478, 8488.490690558587, 8555.786105347415, 8682.325337593316, 559.2701524510471, 579.0359052178161, 598.6168851934765, 611.0, 625.4496043481707, 4158.875233742992, 4220.746755194698, 4236.682248831288, 4246.235677578065, 4323.329883868006, 112359.43820280847, 114285.4285728566, 119258.40370798264, 119551.0, 119998.0, 64084.0, 65506.672466638316, 67300.32699673038, 82340.58829705813, 104073.0, 89807.55096224477, 91607.62588561176, 92573.07426925644, 93911.06088939022, 95547.52226238824, 7110.3044368735755, 7906.7627971160955, 8190.590470476572, 8262.0, 8365.456245344034, 34974.0, 51122.48877511177, 51517.484825152766, 51545.7422712884, 59816.40183598108, 52429.47570524246, 57251.71374143103, 72452.0, 75309.0, 76325.61837190778, 10885.292455990335, 11202.159838012345, 11234.269772464764, 11619.709507262387, 11698.94150529242, 13703.0, 14150.363233654716, 14210.573682789533, 14966.925165374103, 14990.400383984956, 12936.094473386773, 13476.0, 13533.796993044914, 13744.65638359049, 13910.51313204033, 12468.68828279264, 12725.0, 12921.224726516439, 13291.0, 13854.445822167403, 12491.375431228584, 12786.61640150797, 13033.087683862417, 13360.732785344044, 13729.038967272196, 10215.7446063849, 10676.46617669129, 10962.451877405938, 10997.450127493434, 11048.779024419306, 10754.0, 10877.350491296198, 11037.11703063737, 11151.052160566443, 11191.384473854016], "value": 7287.883575144099, "unit": "score"}], "name": "dromaeo_css", "value": 7047.568583153251, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 116.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 120.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 140.0, 92.0, 162.0, 139.0, 139.0, 96.0, 135.0, 174.0, 137.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 185.0, 183.0, 182.0, 182.0, 183.0, 185.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 88.0, 58.0, 59.0, 58.0, 59.0, 82.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 92.0, 69.0, 67.0, 70.0, 87.0, 66.0, 68.0, 89.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 90.0, 86.0, 90.0, 86.0, 87.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 100.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 79.0, 88.0, 80.0, 80.0, 84.0, 85.0, 83.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 55.0, 56.0, 56.0, 58.0, 56.0, 59.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 80.0, 77.0, 66.0, 69.0, 68.0, 70.0, 69.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 83.0, 82.0, 81.0, 82.0, 81.0, 82.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 143.0, 143.0, 151.0, 154.0, 130.0, 154.0, 185.0, 125.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 225.0, 197.0, 165.0, 161.0, 163.0, 160.0, 161.0, 161.0, 159.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1433.7, "alertThreshold": 2.0}]} 08:51:22 INFO - Return code: 0 08:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:51:22 INFO - # TBPL SUCCESS # 08:51:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:22 INFO - 2017-02-13 08:51:22.336 screenresolution[2202:27327] starting screenresolution argv=screenresolution get 08:51:22 INFO - 2017-02-13 08:51:22.339 screenresolution[2202:27327] Display 0: 1600x1200x32@60 08:51:22 INFO - 2017-02-13 08:51:22.344 screenresolution[2203:27330] starting screenresolution argv=screenresolution list 08:51:22 INFO - Available Modes on Display 0 08:51:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:22 INFO - Intel Iris: 08:51:22 INFO - Chipset Model: Intel Iris 08:51:22 INFO - Type: GPU 08:51:22 INFO - Bus: Built-In 08:51:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:22 INFO - Vendor: Intel (0x8086) 08:51:22 INFO - Device ID: 0x0a2e 08:51:22 INFO - Revision ID: 0x0009 08:51:22 INFO - Displays: 08:51:22 INFO - Display: 08:51:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:22 INFO - Display Serial Number: 1600x1200 60 08:51:22 INFO - Main Display: Yes 08:51:22 INFO - Mirror: Off 08:51:22 INFO - Online: Yes 08:51:22 INFO - Rotation: Supported 08:51:22 INFO - Return code: 0 08:51:22 INFO - Running post-action listener: _resource_record_post_action 08:51:22 INFO - [mozharness: 2017-02-13 16:51:22.585804Z] Finished run-tests step (success) 08:51:22 INFO - Running post-run listener: _resource_record_post_run 08:51:22 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 205312; Write bytes: 501122560; Read time: 5; Write time: 1882 08:51:22 INFO - TinderboxPrint: CPU usage
53.3% 08:51:22 INFO - TinderboxPrint: I/O read bytes / time
205,312 / 5 08:51:22 INFO - TinderboxPrint: I/O write bytes / time
501,122,560 / 1,882 08:51:22 INFO - TinderboxPrint: CPU idle
2,239.6 (46.7%) 08:51:22 INFO - TinderboxPrint: CPU system
958.5 (20.0%) 08:51:22 INFO - TinderboxPrint: CPU user
1,599.6 (33.3%) 08:51:22 INFO - TinderboxPrint: Swap in / out
191,217,664 / 0 08:51:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190501376; Write bytes: 188065792; Read time: 18063; Write time: 455 08:51:22 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 192512; Write bytes: 305745408; Read time: 5; Write time: 1396 08:51:23 INFO - Running post-run listener: _upload_blobber_files 08:51:23 INFO - Blob upload gear active. 08:51:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:51:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:51:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:51:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:51:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:24 INFO - (blobuploader) - INFO - Done attempting. 08:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:25 INFO - (blobuploader) - INFO - Done attempting. 08:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:51:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:27 INFO - (blobuploader) - INFO - Done attempting. 08:51:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:27 INFO - Return code: 0 08:51:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:51:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd614f7659392e0c4f336edb3b8477074eebcc87a40d6abe3fc4ebd322e85bffef24d9c80533f6cf9a881ad69fa1ba70c7490a5cafae020af3b9f1abc4b73b42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/434f6f66c348d0776f84c2b79459e95d69f99ef2c4bd8e461272b7cb5a3f297136cba62efc9ac8a798fa6fbdeac8c1de2bc0af4633573fbbed6521dbf07cab48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43e40f6c70f6c0cd711ba0154a8af5e84f1945426a23e31714707771b3a5530df92ebb173f72c9d6c394d3c733790338f78904364760a1c4243b9d60d722c1a3"} 08:51:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:51:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:51:27 INFO - Contents: 08:51:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd614f7659392e0c4f336edb3b8477074eebcc87a40d6abe3fc4ebd322e85bffef24d9c80533f6cf9a881ad69fa1ba70c7490a5cafae020af3b9f1abc4b73b42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/434f6f66c348d0776f84c2b79459e95d69f99ef2c4bd8e461272b7cb5a3f297136cba62efc9ac8a798fa6fbdeac8c1de2bc0af4633573fbbed6521dbf07cab48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43e40f6c70f6c0cd711ba0154a8af5e84f1945426a23e31714707771b3a5530df92ebb173f72c9d6c394d3c733790338f78904364760a1c4243b9d60d722c1a3"} 08:51:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:27 INFO - Copying logs to upload dir... 08:51:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:51:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.466065 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-13 08:51:27.652253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:51:27.659758) ========= 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.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd614f7659392e0c4f336edb3b8477074eebcc87a40d6abe3fc4ebd322e85bffef24d9c80533f6cf9a881ad69fa1ba70c7490a5cafae020af3b9f1abc4b73b42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/434f6f66c348d0776f84c2b79459e95d69f99ef2c4bd8e461272b7cb5a3f297136cba62efc9ac8a798fa6fbdeac8c1de2bc0af4633573fbbed6521dbf07cab48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43e40f6c70f6c0cd711ba0154a8af5e84f1945426a23e31714707771b3a5530df92ebb173f72c9d6c394d3c733790338f78904364760a1c4243b9d60d722c1a3"} build_url:https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/OyT8oZYMTLqYfXdtQ8dntA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dd614f7659392e0c4f336edb3b8477074eebcc87a40d6abe3fc4ebd322e85bffef24d9c80533f6cf9a881ad69fa1ba70c7490a5cafae020af3b9f1abc4b73b42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/434f6f66c348d0776f84c2b79459e95d69f99ef2c4bd8e461272b7cb5a3f297136cba62efc9ac8a798fa6fbdeac8c1de2bc0af4633573fbbed6521dbf07cab48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43e40f6c70f6c0cd711ba0154a8af5e84f1945426a23e31714707771b3a5530df92ebb173f72c9d6c394d3c733790338f78904364760a1c4243b9d60d722c1a3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:51:27.698813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:51:27.699174) ========= 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.sGMZDImYAS/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.C9EKxLTFPR/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005356 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:51:27.747970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:51:27.748276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:51:27.751612) ========= ========= Total master_lag: 0.20 =========