builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0270 starttime: 1479391913.0 results: success (0) buildid: 20161117034731 builduid: 93ac791856a14d468dcc502b09e43d92 revision: 76094c82d70cebcf7e596a43a96585cf3100d64b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.002275) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.002728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.003014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.028460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.028858) ========= 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.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 06:11:53-- 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% 18.7M=0.001s 2016-11-17 06:11:53 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.135960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.136288) ========= 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.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.024646 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:53.184715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 06:11:53.185078) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 76094c82d70cebcf7e596a43a96585cf3100d64b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 76094c82d70cebcf7e596a43a96585cf3100d64b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 06:11:53,286 truncating revision to first 12 chars 2016-11-17 06:11:53,286 Setting DEBUG logging. 2016-11-17 06:11:53,286 attempt 1/10 2016-11-17 06:11:53,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/76094c82d70c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 06:11:55,332 unpacking tar archive at: cedar-76094c82d70c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.301813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-17 06:11:55.508883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:55.509242) ========= script_repo_revision: 76094c82d70cebcf7e596a43a96585cf3100d64b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:55.509646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:55.509930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 06:11:55.528622) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-17 06:11:55.529048) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:11:55 INFO - MultiFileLogger online at 20161117 06:11:55 in /builds/slave/test 06:11:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:11:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:55 INFO - {'append_to_log': False, 06:11:55 INFO - 'base_work_dir': '/builds/slave/test', 06:11:55 INFO - 'blob_upload_branch': 'Cedar', 06:11:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:55 INFO - 'branch': 'Cedar', 06:11:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:55 INFO - 'config_files': ('talos/mac_config.py',), 06:11:55 INFO - 'default_actions': ('clobber', 06:11:55 INFO - 'read-buildbot-config', 06:11:55 INFO - 'download-and-extract', 06:11:55 INFO - 'populate-webroot', 06:11:55 INFO - 'create-virtualenv', 06:11:55 INFO - 'install', 06:11:55 INFO - 'run-tests'), 06:11:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:55 INFO - 'download_minidump_stackwalk': True, 06:11:55 INFO - 'download_symbols': 'ondemand', 06:11:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:55 INFO - 'installer_path': 'installer.exe', 06:11:55 INFO - 'log_level': 'info', 06:11:55 INFO - 'log_name': 'talos', 06:11:55 INFO - 'log_to_console': True, 06:11:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:11:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:11:55 INFO - 'opt_config_files': (), 06:11:55 INFO - 'pip_index': False, 06:11:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:55 INFO - 'cmd': ('bash', 06:11:55 INFO - '-c', 06:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:55 INFO - 'enabled': True, 06:11:55 INFO - 'halt_on_failure': False, 06:11:55 INFO - 'name': 'check_screen_resolution'},), 06:11:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:11:55 INFO - 'cmd': ('bash', 06:11:55 INFO - '-c', 06:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:11:55 INFO - 'enabled': True, 06:11:55 INFO - 'halt_on_failure': False, 06:11:55 INFO - 'name': 'check_screen_resolution'},), 06:11:55 INFO - 'run_cmd_checks_enabled': True, 06:11:55 INFO - 'sps_profile': False, 06:11:55 INFO - 'sps_profile_interval': 0, 06:11:55 INFO - 'suite': 'dromaeojs', 06:11:55 INFO - 'system_bits': '32', 06:11:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:55 INFO - 'title': 't-yosemite-r7-0270', 06:11:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:55 INFO - 'use_talos_json': True, 06:11:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:55 INFO - 'work_dir': 'build'} 06:11:55 INFO - [mozharness: 2016-11-17 14:11:55.745695Z] Running clobber step. 06:11:55 INFO - Running pre-action listener: _resource_record_pre_action 06:11:55 INFO - Running main action method: clobber 06:11:55 INFO - rmtree: /builds/slave/test/build 06:11:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:58 INFO - Running post-action listener: _resource_record_post_action 06:11:58 INFO - [mozharness: 2016-11-17 14:11:58.121423Z] Finished clobber step (success) 06:11:58 INFO - [mozharness: 2016-11-17 14:11:58.121548Z] Running read-buildbot-config step. 06:11:58 INFO - Running pre-action listener: _resource_record_pre_action 06:11:58 INFO - Running main action method: read_buildbot_config 06:11:58 INFO - Using buildbot properties: 06:11:58 INFO - { 06:11:58 INFO - "project": "", 06:11:58 INFO - "product": "firefox", 06:11:58 INFO - "script_repo_revision": "default", 06:11:58 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 06:11:58 INFO - "repository": "", 06:11:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 06:11:58 INFO - "buildid": "20161117034731", 06:11:58 INFO - "pgo_build": "False", 06:11:58 INFO - "basedir": "/builds/slave/test", 06:11:58 INFO - "buildnumber": 2, 06:11:58 INFO - "slavename": "t-yosemite-r7-0270", 06:11:58 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:11:58 INFO - "platform": "yosemite_r7", 06:11:58 INFO - "scheduler": "tests-cedar-macosx64-talos", 06:11:58 INFO - "branch": "cedar", 06:11:58 INFO - "repo_path": "projects/cedar", 06:11:58 INFO - "revision": "76094c82d70cebcf7e596a43a96585cf3100d64b", 06:11:58 INFO - "stage_platform": "macosx64", 06:11:58 INFO - "builduid": "93ac791856a14d468dcc502b09e43d92", 06:11:58 INFO - "slavebuilddir": "test" 06:11:58 INFO - } 06:11:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:11:58 INFO - Running post-action listener: _resource_record_post_action 06:11:58 INFO - [mozharness: 2016-11-17 14:11:58.124938Z] Finished read-buildbot-config step (success) 06:11:58 INFO - [mozharness: 2016-11-17 14:11:58.125069Z] Running download-and-extract step. 06:11:58 INFO - Running pre-action listener: _resource_record_pre_action 06:11:58 INFO - Running main action method: download_and_extract 06:11:58 INFO - mkdir: /builds/slave/test/build/tests 06:11:58 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')]} 06:11:58 INFO - trying https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:11:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 06:11:59 INFO - Downloaded 1199 bytes. 06:11:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:11:59 INFO - Using the following test package requirements: 06:11:59 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:11:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:11:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:11:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'jsshell-mac.zip'], 06:11:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:11:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:11:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:11:59 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:11:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:11:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:11:59 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:11:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:11:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:11:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:11:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:11:59 INFO - Http code: 200 06:11:59 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 06:11:59 INFO - x-amz-cf-id: oF_ThP7ka4NzPVUMiOI0xwAcMRm_f3I7_QzefyvlUl1SmwFYoim2Lg== 06:11:59 INFO - x-amz-version-id: EcNx8JWjblabp5g8ew4fbwc5R6XcqoHf 06:12:00 INFO - Expected file size: 16273334 06:12:00 INFO - Obtained file size: 16273334 06:12:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:12:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:12:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:12:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:12:07 INFO - Http code: 200 06:12:07 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 06:12:07 INFO - x-amz-cf-id: PnQIG8NP-4w4o3ZK0S1etnCBdt1-WcTQuJuO8pC9w6g13d6CnI3SMg== 06:12:07 INFO - x-amz-version-id: EcNx8JWjblabp5g8ew4fbwc5R6XcqoHf 06:12:07 INFO - Expected file size: 16273334 06:12:07 INFO - Obtained file size: 16273334 06:12:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:12:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:12:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:12:15 INFO - Http code: 200 06:12:15 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 06:12:15 INFO - x-amz-cf-id: MeaAeJXcoYNvZcEhAlOJ36vnoL_wvSkPMs3WdF6hICKnGo2gE2p_ZA== 06:12:15 INFO - x-amz-version-id: NF5twGKy2djC2OdIiWlbU17ntwWYu6m1 06:12:15 INFO - Expected file size: 14409389 06:12:15 INFO - Obtained file size: 14409389 06:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:15 INFO - trying https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:12:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 06:12:18 INFO - Downloaded 110935814 bytes. 06:12:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:12:18 INFO - mkdir: /builds/slave/test/properties 06:12:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:12:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:12:18 INFO - Contents: 06:12:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:12:19 INFO - Running post-action listener: _resource_record_post_action 06:12:19 INFO - Running post-action listener: set_extra_try_arguments 06:12:19 INFO - [mozharness: 2016-11-17 14:12:19.453416Z] Finished download-and-extract step (success) 06:12:19 INFO - [mozharness: 2016-11-17 14:12:19.453522Z] Running populate-webroot step. 06:12:19 INFO - Running pre-action listener: _resource_record_pre_action 06:12:19 INFO - Running main action method: populate_webroot 06:12:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:12:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:12:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:12:19 INFO - '--tppagecycles', 06:12:19 INFO - '7'], 06:12:19 INFO - 'tests': ['tsvgm']}}, 06:12:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:12:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:12:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:12:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:12:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['damp', 'tps']}, 06:12:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'tests': ['damp', 'tps']}, 06:12:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['dromaeo_dom']}, 06:12:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:12:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['basic_compositor_video']}, 06:12:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:12:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['a11yr', 06:12:19 INFO - 'ts_paint', 06:12:19 INFO - 'tpaint', 06:12:19 INFO - 'sessionrestore', 06:12:19 INFO - 'sessionrestore_no_auto_restore', 06:12:19 INFO - 'tabpaint']}, 06:12:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['tsvgx', 06:12:19 INFO - 'tsvgr_opacity', 06:12:19 INFO - 'tart', 06:12:19 INFO - 'tscrollx', 06:12:19 INFO - 'cart']}, 06:12:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:12:19 INFO - 'tsvgr_opacity', 06:12:19 INFO - 'tart', 06:12:19 INFO - 'tscrollx', 06:12:19 INFO - 'cart']}, 06:12:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'talos_options': ['--disable-e10s'], 06:12:19 INFO - 'tests': ['tp5o']}, 06:12:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:12:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'talos_options': ['--disable-e10s', 06:12:19 INFO - '--xperf_path', 06:12:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:19 INFO - 'tests': ['tp5n']}, 06:12:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:12:19 INFO - 'talos_options': ['--xperf_path', 06:12:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:19 INFO - 'tests': ['tp5n']}}, 06:12:19 INFO - 'talos.zip': {'path': '', 06:12:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:12:19 INFO - Running post-action listener: _resource_record_post_action 06:12:19 INFO - [mozharness: 2016-11-17 14:12:19.471996Z] Finished populate-webroot step (success) 06:12:19 INFO - [mozharness: 2016-11-17 14:12:19.472103Z] Running create-virtualenv step. 06:12:19 INFO - Running pre-action listener: _resource_record_pre_action 06:12:19 INFO - Running main action method: create_virtualenv 06:12:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:12:19 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 06:12:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:12:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:12:19 INFO - Using real prefix '/tools/python27' 06:12:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:12:20 INFO - Installing distribute.............................................................................................................................................................................................done. 06:12:23 INFO - Installing pip.................done. 06:12:23 INFO - Return code: 0 06:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:12:23 INFO - Reading from file tmpfile_stdout 06:12:23 INFO - Output received: 06:12:23 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) 06:12:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:12:23 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')]} 06:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:23 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')]} 06:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:23 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:23 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 06:12:23 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 06:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:23 INFO - 'HOME': '/Users/cltbld', 06:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:23 INFO - 'LOGNAME': 'cltbld', 06:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:23 INFO - 'MOZ_NO_REMOTE': '1', 06:12:23 INFO - 'NO_EM_RESTART': '1', 06:12:23 INFO - 'PAGER': '/bin/cat', 06:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:23 INFO - 'PWD': '/builds/slave/test', 06:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:23 INFO - 'SHELL': '/bin/bash', 06:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:23 INFO - 'USER': 'cltbld', 06:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:23 INFO - 'XPC_FLAGS': '0x0', 06:12:23 INFO - 'XPC_SERVICE_NAME': '0', 06:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:23 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 06:12:23 INFO - Cleaning up... 06:12:23 INFO - Return code: 0 06:12:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:12:23 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')]} 06:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:23 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')]} 06:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:23 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:23 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 06:12:23 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 06:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:23 INFO - 'HOME': '/Users/cltbld', 06:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:23 INFO - 'LOGNAME': 'cltbld', 06:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:23 INFO - 'MOZ_NO_REMOTE': '1', 06:12:23 INFO - 'NO_EM_RESTART': '1', 06:12:23 INFO - 'PAGER': '/bin/cat', 06:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:23 INFO - 'PWD': '/builds/slave/test', 06:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:23 INFO - 'SHELL': '/bin/bash', 06:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:23 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:23 INFO - 'USER': 'cltbld', 06:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:23 INFO - 'XPC_FLAGS': '0x0', 06:12:23 INFO - 'XPC_SERVICE_NAME': '0', 06:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:23 INFO - Downloading/unpacking psutil>=3.1.1 06:12:23 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 06:12:23 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 06:12:23 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 06:12:23 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 06:12:23 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 06:12:23 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 06:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:12:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:27 INFO - Installing collected packages: psutil 06:12:27 INFO - Running setup.py install for psutil 06:12:27 INFO - building 'psutil._psutil_osx' extension 06:12:27 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 06:12:28 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 06:12:28 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 06:12:28 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 06:12:28 INFO - building 'psutil._psutil_posix' extension 06:12:28 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 06:12:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:12:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:12:28 INFO - ^ 06:12:28 INFO - 1 warning generated. 06:12:28 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 06:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:28 INFO - Successfully installed psutil 06:12:28 INFO - Cleaning up... 06:12:28 INFO - Return code: 0 06:12:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:12:28 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')]} 06:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:28 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')]} 06:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:28 INFO - 'HOME': '/Users/cltbld', 06:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:28 INFO - 'LOGNAME': 'cltbld', 06:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:28 INFO - 'MOZ_NO_REMOTE': '1', 06:12:28 INFO - 'NO_EM_RESTART': '1', 06:12:28 INFO - 'PAGER': '/bin/cat', 06:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:28 INFO - 'PWD': '/builds/slave/test', 06:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:28 INFO - 'SHELL': '/bin/bash', 06:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:28 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:28 INFO - 'USER': 'cltbld', 06:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:28 INFO - 'XPC_FLAGS': '0x0', 06:12:28 INFO - 'XPC_SERVICE_NAME': '0', 06:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:29 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 06:12:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:12:31 INFO - Installing collected packages: mozsystemmonitor 06:12:31 INFO - Running setup.py install for mozsystemmonitor 06:12:31 INFO - Successfully installed mozsystemmonitor 06:12:31 INFO - Cleaning up... 06:12:31 INFO - Return code: 0 06:12:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:31 INFO - 'HOME': '/Users/cltbld', 06:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:31 INFO - 'LOGNAME': 'cltbld', 06:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:31 INFO - 'MOZ_NO_REMOTE': '1', 06:12:31 INFO - 'NO_EM_RESTART': '1', 06:12:31 INFO - 'PAGER': '/bin/cat', 06:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:31 INFO - 'PWD': '/builds/slave/test', 06:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:31 INFO - 'SHELL': '/bin/bash', 06:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:31 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:31 INFO - 'USER': 'cltbld', 06:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:31 INFO - 'XPC_FLAGS': '0x0', 06:12:31 INFO - 'XPC_SERVICE_NAME': '0', 06:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:32 INFO - Downloading/unpacking jsonschema==2.5.1 06:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:12:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:34 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 06:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:12:35 INFO - warning: no files found matching '*.txt' 06:12:35 INFO - no previously-included directories found matching 'build' 06:12:35 INFO - no previously-included directories found matching 'dist' 06:12:35 INFO - no previously-included directories found matching '.git*' 06:12:35 INFO - Installing collected packages: jsonschema, functools32 06:12:35 INFO - Running setup.py install for functools32 06:12:35 INFO - warning: no files found matching '*.txt' 06:12:35 INFO - no previously-included directories found matching 'build' 06:12:35 INFO - no previously-included directories found matching 'dist' 06:12:35 INFO - no previously-included directories found matching '.git*' 06:12:35 INFO - Successfully installed jsonschema functools32 06:12:35 INFO - Cleaning up... 06:12:35 INFO - Return code: 0 06:12:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:35 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 06:12:35 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 06:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:35 INFO - 'HOME': '/Users/cltbld', 06:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:35 INFO - 'LOGNAME': 'cltbld', 06:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:35 INFO - 'MOZ_NO_REMOTE': '1', 06:12:35 INFO - 'NO_EM_RESTART': '1', 06:12:35 INFO - 'PAGER': '/bin/cat', 06:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:35 INFO - 'PWD': '/builds/slave/test', 06:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:35 INFO - 'SHELL': '/bin/bash', 06:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:35 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:35 INFO - 'USER': 'cltbld', 06:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:35 INFO - 'XPC_FLAGS': '0x0', 06:12:35 INFO - 'XPC_SERVICE_NAME': '0', 06:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:12:35 INFO - Cleaning up... 06:12:35 INFO - Return code: 0 06:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:35 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:35 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 06:12:35 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 06:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:35 INFO - 'HOME': '/Users/cltbld', 06:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:35 INFO - 'LOGNAME': 'cltbld', 06:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:35 INFO - 'MOZ_NO_REMOTE': '1', 06:12:35 INFO - 'NO_EM_RESTART': '1', 06:12:35 INFO - 'PAGER': '/bin/cat', 06:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:35 INFO - 'PWD': '/builds/slave/test', 06:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:35 INFO - 'SHELL': '/bin/bash', 06:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:35 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:35 INFO - 'USER': 'cltbld', 06:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:35 INFO - 'XPC_FLAGS': '0x0', 06:12:35 INFO - 'XPC_SERVICE_NAME': '0', 06:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:12:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:38 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 06:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:12:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:39 INFO - Downloading docopt-0.6.1.tar.gz 06:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:12:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:12:39 INFO - Running setup.py install for blobuploader 06:12:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:12:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:12:39 INFO - Running setup.py install for requests 06:12:40 INFO - Running setup.py install for docopt 06:12:40 INFO - Successfully installed blobuploader requests docopt 06:12:40 INFO - Cleaning up... 06:12:40 INFO - Return code: 0 06:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:40 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')]} 06:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:40 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')]} 06:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:40 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:40 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 06:12:40 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 06:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:40 INFO - 'HOME': '/Users/cltbld', 06:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:40 INFO - 'LOGNAME': 'cltbld', 06:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:40 INFO - 'MOZ_NO_REMOTE': '1', 06:12:40 INFO - 'NO_EM_RESTART': '1', 06:12:40 INFO - 'PAGER': '/bin/cat', 06:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:40 INFO - 'PWD': '/builds/slave/test', 06:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:40 INFO - 'SHELL': '/bin/bash', 06:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:40 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:40 INFO - 'USER': 'cltbld', 06:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:40 INFO - 'XPC_FLAGS': '0x0', 06:12:40 INFO - 'XPC_SERVICE_NAME': '0', 06:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:40 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-dygw2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-de0rmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-sa6JYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-1WyCOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-7xzRmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-kT3sWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-ElkxfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-OICuCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-DiDCtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:41 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-0Qv6nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Xy3FqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-U93GQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-7ufO9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-Q6s4G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-krbpat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-2vanMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:42 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-igHOc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:12:42 INFO - Running setup.py install for manifestparser 06:12:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:12:42 INFO - Running setup.py install for mozcrash 06:12:43 INFO - Running setup.py install for mozdebug 06:12:43 INFO - Running setup.py install for mozdevice 06:12:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Running setup.py install for mozfile 06:12:43 INFO - Running setup.py install for mozhttpd 06:12:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Running setup.py install for mozinfo 06:12:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Running setup.py install for mozInstall 06:12:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:12:43 INFO - Running setup.py install for mozleak 06:12:44 INFO - Running setup.py install for mozlog 06:12:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Running setup.py install for moznetwork 06:12:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Running setup.py install for mozprocess 06:12:44 INFO - Running setup.py install for mozprofile 06:12:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Running setup.py install for mozrunner 06:12:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:12:44 INFO - Running setup.py install for mozscreenshot 06:12:45 INFO - Running setup.py install for moztest 06:12:45 INFO - Running setup.py install for mozversion 06:12:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:12:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:12:45 INFO - Cleaning up... 06:12:45 INFO - Return code: 0 06:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12: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')]} 06:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:45 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:45 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 06:12:45 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 06:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:45 INFO - 'HOME': '/Users/cltbld', 06:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:45 INFO - 'LOGNAME': 'cltbld', 06:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:45 INFO - 'MOZ_NO_REMOTE': '1', 06:12:45 INFO - 'NO_EM_RESTART': '1', 06:12:45 INFO - 'PAGER': '/bin/cat', 06:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:45 INFO - 'PWD': '/builds/slave/test', 06:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:45 INFO - 'SHELL': '/bin/bash', 06:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:45 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:45 INFO - 'USER': 'cltbld', 06:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:45 INFO - 'XPC_FLAGS': '0x0', 06:12:45 INFO - 'XPC_SERVICE_NAME': '0', 06:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:12:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-24BGdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:12:45 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)) 06:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:12:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-U2L9YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:12:45 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)) 06:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:12:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-V_zlW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:12:45 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)) 06:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:12:45 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-C4ClXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-OqFuFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-FxaHno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-vQHajJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-LZFDuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-bZRDPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-kIk198-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-jZlDMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-tVT3S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-OvLkx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:12:46 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)) 06:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:12:46 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-IztxNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:12:47 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)) 06:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-kmCMxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:12:47 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)) 06:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:12:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-oykXBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:12:47 INFO - Running setup.py (path:/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/pip-d8lYfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:12:47 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)) 06:12:47 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)) 06:12:47 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)) 06:12:47 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)) 06:12:47 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)) 06:12:47 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)) 06:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:12:49 INFO - Downloading blessings-1.6.tar.gz 06:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:12:50 INFO - Installing collected packages: blessings 06:12:50 INFO - Running setup.py install for blessings 06:12:50 INFO - Successfully installed blessings 06:12:50 INFO - Cleaning up... 06:12:50 INFO - Return code: 0 06:12:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:50 INFO - Reading from file tmpfile_stdout 06:12:50 INFO - Current package versions: 06:12:50 INFO - blessings == 1.6 06:12:50 INFO - blobuploader == 1.2.4 06:12:50 INFO - docopt == 0.6.1 06:12:50 INFO - functools32 == 3.2.3-2 06:12:50 INFO - jsonschema == 2.5.1 06:12:50 INFO - manifestparser == 1.1 06:12:50 INFO - mozInstall == 1.12 06:12:50 INFO - mozcrash == 1.0 06:12:50 INFO - mozdebug == 0.1 06:12:50 INFO - mozdevice == 0.48 06:12:50 INFO - mozfile == 1.2 06:12:50 INFO - mozhttpd == 0.7 06:12:50 INFO - mozinfo == 0.9 06:12:50 INFO - mozleak == 0.1 06:12:50 INFO - mozlog == 3.4 06:12:50 INFO - moznetwork == 0.27 06:12:50 INFO - mozprocess == 0.23 06:12:50 INFO - mozprofile == 0.28 06:12:50 INFO - mozrunner == 6.13 06:12:50 INFO - mozscreenshot == 0.1 06:12:50 INFO - mozsystemmonitor == 0.3 06:12:50 INFO - moztest == 0.7 06:12:50 INFO - mozversion == 1.4 06:12:50 INFO - psutil == 3.1.1 06:12:50 INFO - requests == 1.2.3 06:12:50 INFO - wsgiref == 0.1.2 06:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:51 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:51 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 06:12:51 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 06:12:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:51 INFO - 'HOME': '/Users/cltbld', 06:12:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:51 INFO - 'LOGNAME': 'cltbld', 06:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:51 INFO - 'MOZ_NO_REMOTE': '1', 06:12:51 INFO - 'NO_EM_RESTART': '1', 06:12:51 INFO - 'PAGER': '/bin/cat', 06:12:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:51 INFO - 'PWD': '/builds/slave/test', 06:12:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:51 INFO - 'SHELL': '/bin/bash', 06:12:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:51 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:51 INFO - 'USER': 'cltbld', 06:12:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:51 INFO - 'XPC_FLAGS': '0x0', 06:12:51 INFO - 'XPC_SERVICE_NAME': '0', 06:12:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 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)) 06:12:51 INFO - Cleaning up... 06:12:51 INFO - Return code: 0 06:12:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:12:52 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 0x10b3393f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2af570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa15856a6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, '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.4TgC8HLd1M/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.BKDsrULyEl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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 06:12:52 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 06:12:52 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 06:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:12:52 INFO - 'HOME': '/Users/cltbld', 06:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:12:52 INFO - 'LOGNAME': 'cltbld', 06:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:52 INFO - 'MOZ_NO_REMOTE': '1', 06:12:52 INFO - 'NO_EM_RESTART': '1', 06:12:52 INFO - 'PAGER': '/bin/cat', 06:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:52 INFO - 'PWD': '/builds/slave/test', 06:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:12:52 INFO - 'SHELL': '/bin/bash', 06:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:12:52 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:12:52 INFO - 'USER': 'cltbld', 06:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:52 INFO - 'XPC_FLAGS': '0x0', 06:12:52 INFO - 'XPC_SERVICE_NAME': '0', 06:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:12:52 INFO - Cleaning up... 06:12:52 INFO - Return code: 0 06:12:52 INFO - Running post-action listener: _resource_record_post_action 06:12:52 INFO - Running post-action listener: _start_resource_monitoring 06:12:52 INFO - Starting resource monitoring. 06:12:52 INFO - [mozharness: 2016-11-17 14:12:52.313756Z] Finished create-virtualenv step (success) 06:12:52 INFO - [mozharness: 2016-11-17 14:12:52.314689Z] Running install step. 06:12:52 INFO - Running pre-action listener: _resource_record_pre_action 06:12:52 INFO - Running main action method: install 06:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:12:52 INFO - Reading from file tmpfile_stdout 06:12:52 INFO - Detecting whether we're running mozinstall >=1.0... 06:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:12:52 INFO - Reading from file tmpfile_stdout 06:12:52 INFO - Output received: 06:12:52 INFO - Usage: mozinstall [options] installer 06:12:52 INFO - Options: 06:12:52 INFO - -h, --help show this help message and exit 06:12:52 INFO - -d DEST, --destination=DEST 06:12:52 INFO - Directory to install application into. [default: 06:12:52 INFO - "/builds/slave/test"] 06:12:52 INFO - --app=APP Application being installed. [default: firefox] 06:12:52 INFO - mkdir: /builds/slave/test/build/application 06:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:13:26 INFO - Reading from file tmpfile_stdout 06:13:26 INFO - Output received: 06:13:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:13:26 INFO - Running post-action listener: _resource_record_post_action 06:13:26 INFO - [mozharness: 2016-11-17 14:13:26.371515Z] Finished install step (success) 06:13:26 INFO - [mozharness: 2016-11-17 14:13:26.371654Z] Running run-tests step. 06:13:26 INFO - Running pre-action listener: _resource_record_pre_action 06:13:26 INFO - Running main action method: run_tests 06:13:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:26 INFO - 2016-11-17 06:13:26.386 screenresolution[1622:7333] starting screenresolution argv=screenresolution get 06:13:26 INFO - 2016-11-17 06:13:26.389 screenresolution[1622:7333] Display 0: 1600x1200x32@60 06:13:26 INFO - 2016-11-17 06:13:26.394 screenresolution[1623:7335] starting screenresolution argv=screenresolution list 06:13:26 INFO - Available Modes on Display 0 06:13:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:26 INFO - Intel Iris: 06:13:26 INFO - Chipset Model: Intel Iris 06:13:26 INFO - Type: GPU 06:13:26 INFO - Bus: Built-In 06:13:26 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:26 INFO - Vendor: Intel (0x8086) 06:13:26 INFO - Device ID: 0x0a2e 06:13:26 INFO - Revision ID: 0x0009 06:13:26 INFO - Displays: 06:13:26 INFO - Display: 06:13:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:26 INFO - Display Serial Number: 1600x1200 60 06:13:26 INFO - Main Display: Yes 06:13:26 INFO - Mirror: Off 06:13:26 INFO - Online: Yes 06:13:26 INFO - Rotation: Supported 06:13:26 INFO - Return code: 0 06:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:13:26 INFO - Python 2.7.3 06:13:26 INFO - Return code: 0 06:13:26 INFO - grabbing minidump binary from tooltool 06:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:26 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 0x10b14fd30>, '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 0x10afb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b147b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:13:26 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 06:13:26 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 06:13:26 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 06:13:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:13:26 INFO - Return code: 0 06:13:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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 06:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0270 --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 06:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TgC8HLd1M/Render', 06:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:26 INFO - 'HOME': '/Users/cltbld', 06:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:26 INFO - 'LOGNAME': 'cltbld', 06:13:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:13:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:26 INFO - 'MOZ_NO_REMOTE': '1', 06:13:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:13:26 INFO - 'NO_EM_RESTART': '1', 06:13:26 INFO - 'PAGER': '/bin/cat', 06:13:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:26 INFO - 'PWD': '/builds/slave/test', 06:13:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:26 INFO - 'SHELL': '/bin/bash', 06:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BKDsrULyEl/Listeners', 06:13:26 INFO - 'TMPDIR': '/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/', 06:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:26 INFO - 'USER': 'cltbld', 06:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:26 INFO - 'XPC_FLAGS': '0x0', 06:13:26 INFO - 'XPC_SERVICE_NAME': '0', 06:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0270', '--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 06:13:26 INFO - mozversion application_buildid: 20161117034731 06:13:26 INFO - mozversion application_changeset: 76094c82d70cebcf7e596a43a96585cf3100d64b 06:13:26 INFO - mozversion application_display_name: Nightly 06:13:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:13:26 INFO - mozversion application_name: Firefox 06:13:26 INFO - mozversion application_remotingname: firefox 06:13:26 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:13:26 INFO - mozversion application_vendor: Mozilla 06:13:26 INFO - mozversion application_version: 53.0a1 06:13:26 INFO - mozversion platform_buildid: 20161117034731 06:13:26 INFO - mozversion platform_changeset: 76094c82d70cebcf7e596a43a96585cf3100d64b 06:13:26 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:13:26 INFO - mozversion platform_version: 53.0a1 06:13:26 INFO - using testdate: 1479392006 06:13:26 INFO - actual date: 1479392006 06:13:26 INFO - starting webserver on 'localhost:49241' 06:13:26 INFO - SUITE-START | Running 2 tests 06:13:26 INFO - TEST-START | dromaeo_css 06:13:26 INFO - operating with platform_type : mac_ 06:13:26 INFO - Initialising browser for dromaeo_css test... 06:13:26 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp4RBN62/profile http://localhost:49241/getInfo.html) 06:13:29 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 06:13:29 INFO - PROCESS | 1633 | colorDepth:24 06:13:29 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 06:13:29 INFO - PROCESS | 1633 | __metrics 06:13:29 INFO - PROCESS | 1633 | 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" 06:13:29 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:30 INFO - TEST-INFO | 1633: exit 0 06:13:30 INFO - Browser initialized. 06:13:30 INFO - Running cycle 1/1 for dromaeo_css test... 06:13:30 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp4RBN62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:42 INFO - PROCESS | 1635 | RSS: Main: 238804992 06:13:42 INFO - PROCESS | 1635 | 06:14:33 INFO - PROCESS | 1635 | 1479392073912 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:16:47 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:16:50 INFO - PROCESS | 1635 | RSS: Main: 458121216 06:16:50 INFO - PROCESS | 1635 | 06:19:52 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:19:53 INFO - PROCESS | 1635 | RSS: Main: 368664576 06:19:53 INFO - PROCESS | 1635 | 06:22:56 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:22:56 INFO - PROCESS | 1635 | RSS: Main: 360296448 06:22:56 INFO - PROCESS | 1635 | 06:25:58 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:25:59 INFO - PROCESS | 1635 | RSS: Main: 345202688 06:25:59 INFO - PROCESS | 1635 | 06:29:02 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:29:03 INFO - PROCESS | 1635 | RSS: Main: 330510336 06:29:03 INFO - PROCESS | 1635 | 06:32:06 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:32:07 INFO - PROCESS | 1635 | RSS: Main: 468799488 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | __start_tp_report 06:32:07 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 06:32:07 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 06:32:07 INFO - PROCESS | 1635 | |i|pagename|runs| 06:32:07 INFO - PROCESS | 1635 | |0;dojo.html;2986.7306394782213;3314.988928376845;3330.7168890644302;3345.9163520911975;3383.9323213535713;5501.147322165066;5539.584531160159;5638.661680299185;5695.658260504368;5713.143028545715;5643.830685079454;5649.322081350233;5721.31344238692;5725.255716756827;5740.540756739471;5026.271190677349;5047.192449208127;5076.44159142494;5130.769115389817;5149.0731668299695;5213.635045546814;5234.895302093956;5235.947640523584;5246.344206974129;5319.20211968204;5109.540141387293;5217.295665085203;5242.6330156889035;5247.816326428595;5334.146536554152;5130.333056702605;5193.039287731744;5194.610404219661;5195.610329225286;5201.479852014806;5080.466551012164;5149.330587023663;5154.046501397216;5170.767315470813;5183.766730497136;5639.68981706006;5640.830775076754;5645.237892884449;5648.576356773258;5651.2935883014625;6103.102203373851;6121.737397888052;6126.731429653759;6130.184124957599;6134.142567655225;5050.494950504957;6172.753089876444;6188.443040126365;6192.349803270637;6198;5628.887422251573;5693.259876216065;5695.487406133427;5701.4013528579735;5711.600187986843;5282.445343238982;6205.162303089025;6232.376762323732;6258.3428739982555;6275.6862156891975;6075.392460753889;6087.29996050451;6094.939050609526;6109;6109.908351374733;6051.7579296827635;6110.315755985069;6122.234720659918;6122.448979591858;6237.189165408558;5038.521340472649;6151.200343955257;6168.414000669929;6168.629882207082;6175.5677102602385;6192.907106393408;6195.411435913581;6195.938040619626;6202.317745048041;6208.379162083756;4740.217864052462;4764.547368000104;4888.560029597354;4892.510748925079;4918.43438004634;4340.305551111807;4370.278903980871;4403.911921761611;4448.354988526646;4469.329600559942;5663.348714897757;5666.235058267163;5668.206451096849;5670.971645141748;5673.461021202979;6124.197855633957;6161.921663708833;6168.321484636686;6178.62928224308;6191.133241346215;4763.618910487153;5612.494875461228;5672.8865422691315;5684.175794509855;5686.857828554236;4663.720176789404;5308.0710875596615;5313.388960269541;5363.570914326844;5371.462853714597;6218.81343559694;6269.529785266214;6287.371262873768;6346.8413289667205;6365.172527571386;6258.499320054476;6268.279147897868;6285.497160227263;6288.245410550763;6298.02380631003;6194;6304.936950630435;6317.96841015792;6319.178506794087;6324.4940404766585;5964.254468191476;5978.521718262616;6036.456718895321;6077.939220607737;6134.04922237054;6228.719707613078;6239.1577137085915;6244.375562443901;6244.469220116341;6264.154339164154;5951.92865284253;6053.940560402;6061.484773794101;6075.058365953284;6085.2393450818645;5120.436751957356;5815.127730840408;5887.970560147171;5893.2044174035955;5963.105534169909;5749.108888122348;5776.624519406225;5787.710614469344;5787.797427090031;5791.53667706574;5941.435563621449;5983.311919129182;5996.730147143477;6006.099085137264;6009.36901625323;5836.824895253149;5839.620424672383;5847.5906686533235;5847.970760146172;5853.765849365977 06:32:07 INFO - PROCESS | 1635 | |1;ext.html;449.9662525310602;465.7717718318021;510.00803437314426;519.0656817728091;552.6131707804537;31967.52048719268;33125.00624981248;33172.33655326895;33176.50235246473;34354.828225858895;32739;33061.834690826574;33079;33116.85389887963;33154.50268245972;6840.837057700203;7230.457715671332;7404.62976851158;7410.666520006613;7453.888191677102;7270.636468176596;7675.15573286938;7706.6146692665425;7759.107702614215;7764.650590723431;7718.575478348688;7747.264009919077;7756.806079847993;7756.883646745303;7757.49576277543;7676.270754278335;7698.692052317929;7737.767866964;7740.26467485588;7744.993150890405;7584.393248540104;7658.540487570764;7659.808504787425;7677.539347639159;7683.7310694126;30908.536371954215;31246.53130203049;31263.687363126304;31301.37397252065;31310.686893131005;3257.2833976525126;3283.228441316289;3391.406503861814;3491.423915054013;3502.352064867982;21862.01620927062;21868.562628747335;21921.671174932388;21945.780542194534;22115;2724.455108978212;2861.1702606244166;2887.2493151780686;2935.222166125978;2935.6036935013713;474851;477991.61004195106;478316;478806;479173.60413198057;56341.15488267679;56714.71642641843;56726.14910776342;56805;56810.71594642;59461.108083378786;59504.107438388455;59531;59573.40426595765;59602.105968410506;15272;15509.146996915053;15510.689786204213;15536;15541.300641471162;11577.826332605018;11587.478563464665;11596.594119205787;12110.81833772494;12211.450484728208;12678.936605316914;15509.612259693373;15529.767053494206;15570.496638256302;15653;6709.463242940553;6712;6766.4248538874745;6780.355866192704;6804.251532331439;891.416122439803;931.9207867331353;934.8878134623889;962.4562122400821;1066.1540671895043;26669.466610667678;28843.134705958855;28917.69870355839;29079.41841163165;29687.554686679716;879.5953861223909;990.1929927109383;1033.3489901362093;1044.5978298355187;1088.8149014667526;13704.314784260747;15089.924550377398;15465.536033919001;15506.612334691723;15841.841581584036;633793;636250;636907;638594;651002;51500.48499515032;51722.74138629283;51761.48238517567;51899.74050129801;52030.73984630052;1199.1006744941294;1228.2875931959443;1285.1967520299813;1321.7224382879704;1341.2958196946681;27701.30746731348;28818.711812881604;29110.557938197686;29170.56244156382;29329.973450929116;35511.644883550834;43624.12751744884;44040.339394909744;44164.337534936356;44255.11489770251;533192;534853;536209;537475;538504;21451.78548214498;21939;22827.20104796324;23243.186488472824;23453.648195277427;39785.83319585469;40109;40338.853515829156;40785.77642670725;40818.79590602028;32866.50700239451;33499.162520936196;33691.83154084214;34354.656453436146;34418.48372274468;33318.333633326714;33602.32795344129;33935;34172.31655366928;34505.482417763254;34215.82892085524;34674.47988280127;34818.65181348154;34875.30249394947;34992.82503587466;29148.417031659672;30249.546256805726;30465;30504.694953051072;30862.382752345275;23016.654750178426;23179.4205144866;23337.41656458602;23534.29397118089;23683.289501314986 06:32:07 INFO - PROCESS | 1635 | |2;jquery.html;361.7449697962936;367.5570937020888;367.93377192105424;383.1436689240628;391.9216156768645;15233.086014839117;15809.525714228577;16117.597060073489;16222.432214872482;16229.756553651676;14205;17441;18200.817991820077;18959.52601184971;19010.429687109376;4775.259834725614;5144.1254986652175;5145.485451454862;5146.665466744649;5151.098557752397;3398.915027124317;3610.530631017964;3611.259691763182;4800.207965685658;5011.624128190382;5013.5989120870245;5101.948980510185;5113.642045056848;5119.334486516747;5119.820806271781;4850.490698476645;5009.77614620327;5032.547070763649;5071.96024814912;5100;4479.686421950465;4487.551244875519;4490.955090449119;4491.663125265618;4505.707129036602;19738.80261197384;20812;20842.27052053186;21017.579648406947;21067;1975.3580086471811;2316.7219933607907;2334.9533009339716;2440.1947357372023;3078.4304903592906;8969.775755606097;9104.590293436811;9508.804264890967;9516.809663806755;13295.3352332383;1632.428649972512;1664.2594045649691;1713.8200488948605;1715.3567412220418;1731.5584525945928;98212;128898.06652900214;130202;130355.34822325828;131184;10613.734656633645;11094.611688590861;11209.159313051554;11297.435128243555;11566.826497602542;14270.714585708227;14297;14303.356348964322;14314.570562883131;14333.498327558485;8000.439969202216;8040.678372865137;8208.231006892209;8217.630206640715;8368.874466883002;8024.759257222293;8093.514389136671;8106;8262.586870656443;8293.875591866126;3813.7033408641196;4299.14017196562;4322;4422.358757980075;4534.546545345439;1654.793150856143;1731.2036463227057;1863.9720404193947;1897.297999740105;1924.9903750481158;711.6441779110445;729.2598013016792;832.3840358134937;867.5271976772548;920.581135583308;18696.719549206773;19196.040197990045;20435.897820510803;20482.078306476244;20611.278605248743;736.7642354446525;852.9914700853036;887.8135591525852;934.9859752103724;961.9178424272693;10167.593296268215;10658.680239592824;10706.464676766287;10750.301230419998;10776.838347424795;487192;491146;493854;570820;579658;83544;131190;132901.33549332386;134678;136684.31657841845;875.7679215008028;964.7202311329776;984.17329443268;986.1863962231188;989.7129832348683;17468.515176210163;17886.105694715472;17962.19170137373;18017.009064501577;18405.355812546495;42446.787766060974;52053.7397313011;55911;57695.7115214438;59462.10806837987;79319;79564.43588190305;80728;81227.5938620303;81959.18040819754;6880.243173251039;7228.060352154186;7263.309985551364;7334.633268336668;7450.366718828744;9782.706518804447;12242.265464072185;12457.626271211879;12631.305278209788;12694.809577856155;9457.763555910882;10247.897521024992;10278.280520363802;11146.554137834395;11248.26886252391;8502.131530153889;10270.486475676336;11072.224944253825;11139.33164010162;11253;9890.75273118149;10853.728656783327;11023.6850261446;11196.272242304223;11248.94375528117;7254.637268136466;7284.271572842674;7356.190819010012;7561.357284630868;7574.204708505748;10674.62638807638;10795.352278863293;11037.633521775935;11223.38271395081;11449.713757156138 06:32:07 INFO - PROCESS | 1635 | |3;mootools.html;1337.4516448256213;1476.2544914818022;1479.874210692091;1500.7523758579835;1512.9394824207031;7650.693972241111;8021.4384993050435;8024.996875390576;8025.197480251972;8029.799255018627;7143.607101609409;7384.372328352083;7406.740764073258;7777.261160189787;7947.960260198705;2004.2584243829767;2057.9485512862225;2059.6292667319876;2061.391889392633;2066.493709041287;2054.4555692741437;2069.9172033118657;2082.6980087887246;2084.551821358408;2108.5677436125557;1817.463848164788;1888.4806678163545;1891.2718603337746;1957.1779852462;1995.1321175288724;1984.464194667439;2060.763012253595;2062.6390381683145;2064.834813214939;2074.3258441006656;2057.86623869448;2066.9379918602467;2077.7714451410334;2078.3453212238096;2091.1321801452377;7918.920810791934;7948;8006.839863202703;8037.316828069621;8045.637946292431;5026.346574945271;5192.1173400522;5205.401378841444;5205.973970130163;5212.113940630102;2757.8621068946472;3428.8457019434186;3469.9653003469894;3534.169470174507;3535.717142628609;977.8582105594649;989;1001.5943542865151;1003.914667253277;1012.4229189362067;10872.293300935493;10972.506237219344;11027.503762330714;11044.668659940215;11044.791041791594;4143.834246630101;4291.356296555542;4357.368181613649;4391.473023237232;4404.383386325917;8682.913170868336;8684.478931264144;8696.565171741388;8697.347698922606;8702.82594348122;5034.471380505068;5042.092423363756;5047.242913562922;5050.873728156752;5057.241413787961;4554.590086892129;4692.085043416501;4746.95253047472;4750.168720473903;4750.406199225097;3525.453554699026;3582.5880023797076;3583.480395342661;3616.909577260537;3649.2883887641656;1109.5187924121387;1116.3525155409843;1128.6275529075385;1131.643532287327;1133.7789131119519;673.3468535520537;775.5501808950795;809.3484744780508;836.9121242269596;853.620139038122;5142.845714628567;5295.232191332235;5375;5540.86147846299;5574.219609254707;387.0555843741262;397.63616291093325;412.43496409918606;415.5532802237607;417.2114703210934;3509.824508774551;3543.5924868639922;3663.505426767352;3692.2430901665093;3706.369917114097;9491.715248542554;10051.64819231338;10112.241581881388;10170;10205.38767673927;9970.501474926225;10101;10214.38713677167;10221.795564088825;10230.897691022994;7535.886961695579;7693.807654808675;7702.576358300347;7823.178566250462;7860.135385107634;5283.524482796567;5470.617056805985;5505.697186654773;5563.554915606823;5666.886662266814;8072.354211663171;9451.480168590793;9467.053294670477;9504.85742713846;9514.33399662017;9255.25957923378;9721.319507634398;9727.951360243154;9736.853947190657;9757.609695612096;6710.563813352116;6795.626240556817;6803.319668033157;6804.659767011531;6812;7805.063392392949;7854.1360450349275;7877.7636670899965;7937.920620793718;7981.201879812204;6955.23492415844;7096.716131354688;7162.89255661155;7201.963990180016;7247.420206383582;6754.459643228432;6754.6622668865375;6895.689693963684;7083.964580177066;7152.892706609509;5692.829215123553;6647.135872336566;6789.11741473625;6798.76204332846;6804.761833336008;4671.906561868675;4776.5701086902345;4861;4898.21628539432;4957.454679985271;4478.126765280739;4540.151371618246;4649.3026046093355;4779.330893674958;4787.449443313924 06:32:07 INFO - PROCESS | 1635 | |4;prototype.html;228.9610766169751;281.30237012209733;301.06519257704826;304.4717415284481;311.18469609622775;4741.834035808747;4828.830990915319;4846.491118432562;5237.402592209374;5239.371275446952;3938.4289278054734;4279.679024073192;5192.676686920374;5200.765965531551;5218.060749065166;3924;3941.822617982183;3971.721979461439;3973.092915400595;3980.1044764927806;3246.399416108016;3583.4624806279135;3948.605139486043;3948.6771931403014;3973.9205215895663;3474.6699063589044;3847.3459511882907;3965.235470215755;3965.325894597925;3973.8211780469946;3283.5731354923705;3824.934535350907;3941.896269044672;3983.9004024899464;3992.540857801361;2779.984511229363;2979.433907557579;3459.446488561843;3462.5844898612327;3473.808940508271;4308.836614114203;4765.237561990065;5076.543111120017;5097.898042039175;5146.9485305146845;3346.397648423283;3906.433567132778;4189.973456503176;4439.844605438827;4464.352668863029;4743.1738780569385;5240.68555886648;5420.539254163361;5429.619926605139;5456.863578410532;3285.8663761002417;3494.790312581253;3697.334479793636;3713.498677678506;3721.7062899334283;4675.322078298662;4697.647676424213;5537.695426751487;5682.602217844753;5691.51622112121;3240.946692325004;3448.3965306071336;3704.7036237100965;3767.246550689873;3809.2000679857542;3684.631536846294;3847.3459511883048;3853.9807300963316;3860.4981352424006;3868.903277418031;3673.834677439522;4174.08170202555;4390.846320378771;4424.75663838492;4437.245668236407;4441.444819397575;5013.846815232517;5420.395437034407;5425;5449.073657478239;1198.670365649436;1229.0045063498594;1248.8376511053505;1250.474800583739;1250.974980500403;709.907711997437;809.1261437647445;830.5805568188026;847.220557087481;868.6134670071883;4006.3189257825657;4183.267928112568;4329.437173167468;4821.807127714922;4914.8034078637165;4439.64482841372;4454.977725111418;4478.149151661174;5303.522682958553;5333.653312534673;4482.2743243851355;4553.499115097403;4737.123632128068;4882.26765985098;4885.682430641997;2351.5179388225374;2448.6571879936823;2747.931301717433;2775.3616668166433;2791.3858951030743;4652.18564759744;4903.166461701519;5083.923741143886;5495.41133153813;5529.170624406291;4546.476930228345;4756;5011.824586139541;5344.759485823147;5430.67415955044;4907.852764417074;5029.5221953914315;5055.6713813602;5513.641613295123;5523.685788526932;4967.925481117858;5254.500822421864;5300.296848607315;5302;5394.919076213781;4653.348531205702;4790.383260638196;5086.18621020635;5187.09225885461;5195.480451954925;5086.313347698161;5798.303374266858;5809.215755873072;5833.79581714638;5856.887191433614;3129.906102816919;3148.039847846337;3329.7003269705842;3637.436197389409;3757.9248415032093;4719.504452032487;4729.9054018920115;5247.4227834937365;5642.915356269577;5694.092479019409;4774.448304301047;5001.2992983788345;5365.873166634894;5459.836204913859;5478.424765399735;4801.447833499193;5001.24981252815;5435.429279925551;5460.918086228789;5471.151971444432;4665.486796452456;5107.565856902205;5198.989854062498;5249.47505249472;5347.117725575236;5145.279660847409;5429.457054294539;5431;5444.537214336668;5453.672779633076;4824.587706146926;4841.322214889989;5322.042032434199;5350.2242174885205;5352.036633405869 06:32:07 INFO - PROCESS | 1635 | |5;yui.html;656.8456412743006;736.1718067174429;769.8375453065869;782.9569373684449;788.428389417672;12941;13394.263315517643;13398.66503337417;13421.859141972931;13434.46262149514;12446.937765311184;12566.057545684087;12570.30863302518;12577.18248313859;12579.811302830465;631.4222486424916;650.8307839961597;783.3224261014238;812.8293058457731;828.693383448125;810.3112354498659;827.8840962265258;828.4035494443991;830.622066959535;831.0899564976341;866.9176428239307;868.8436081505326;872.4590753732695;872.6116877989298;873.3100850328233;677.9864402711918;697.9965100174467;859.7893516088536;861.840559496492;862.607513581319;619.6529943231805;626.2672672972587;633.6578247746212;634.4670476799464;637.8501052252717;11852.288862668267;11901.940490297493;11909.880901190963;11913.702157446047;11930.284182949052;10401.53193106312;10588.94705526475;10619.36283822973;10714.410707411167;11029.61396351124;9123.583903412547;9156.954215228881;9213.401128926665;9454.14912657864;9470.857937130948;3008.3832814273023;3021.30509982703;3045.057269425713;3134.13811201919;3140.1678555182893;71002.64498677525;72025.63987180083;84517.73223401654;85859.57070214608;93069.53465232698;8322.292605128632;8325.458845175044;8461.323094152453;8479.745607631781;8647.697330593399;17255.482335529956;17364.739528907077;17407.651846963243;17417.738733918748;17426.780125391102;6937.583744975318;7259.89110163348;7345.816354591071;7374.041374621373;7649.005629268159;4119.320312148522;4169.8957526062095;4181.937270940938;4184.958150418518;4212.283911735012;2714.511387950188;3266.5100234964943;3336.9499457508155;3339.6159441664036;3341.064501939461;525.2987262005266;621.0901029991085;634.238913304037;635.5043066408117;641.5477088652489;514.4937252623359;578.6470253145578;590.5423296944903;612.6936531734133;617.5800455690083;8238.958805205935;8252.628631711588;8293.320397192358;8300.377471689648;8488.423742432706;535.8821059366933;577.7717801468397;591.6272748168712;594.1236675903009;615.5168192968498;3850.4224366345275;3954.149857780591;4011.959880401217;4052.068024354356;4070.470838790938;68650.59722909675;74975.87536186962;103977.48011259895;107262;113093.43453282681;73235;92538;96192;96193.5570966436;98544.50727746458;79820.80268795857;81224.18775812167;82597.58701206456;87043.56478217569;88651.55674221588;6849.691763870538;8398.454100483448;8599.39804213724;8697.91302086971;8712.259457945893;42298.577014230694;51461;52191.47808521866;53343.73328133334;55571.16643250435;68995.65502172457;70847.64576177087;75211;78670;79805.60097199709;11268.549258029587;11548.769024619629;11587.768244635228;11592.942035289769;11618.88381116178;12084.45619947122;12134.817977730165;12243.632691019284;12505.56230531927;12957.157784743962;11493.138014649103;11664.900317942513;12044.337561434206;12181.147319687538;12270.938645306716;11675.649730508097;11791.410429478321;11942.641720748392;12220.388980550759;12262.4481898313;9256.352055356061;11509.251898626562;11541.076713863038;11995.700107497383;12025.932250506445;9325.958901029679;9682.046975672487;9720.319577629782;9954.153896918842;10138.49307534635;8970.910290897007;10176.287659863738;10264.178865690876;10276.22928280367;10335.638252661121 06:32:07 INFO - PROCESS | 1635 | __end_tp_report 06:32:07 INFO - PROCESS | 1635 | __start_cc_report 06:32:07 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2694 06:32:07 INFO - PROCESS | 1635 | __end_cc_report 06:32:07 INFO - PROCESS | 1635 | __startTimestamp1479393127036__endTimestamp 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | ------- Summary: start ------- 06:32:07 INFO - PROCESS | 1635 | Number of tests: 6 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5655.31 Median:5787.80 stddev:647.66 (11.2%) stddev-sans-first:614.88 06:32:07 INFO - PROCESS | 1635 | Values: 2986.7 3315.0 3330.7 3345.9 3383.9 5501.1 5539.6 5638.7 5695.7 5713.1 5643.8 5649.3 5721.3 5725.3 5740.5 5026.3 5047.2 5076.4 5130.8 5149.1 5213.6 5234.9 5235.9 5246.3 5319.2 5109.5 5217.3 5242.6 5247.8 5334.1 5130.3 5193.0 5194.6 5195.6 5201.5 5080.5 5149.3 5154.0 5170.8 5183.8 5639.7 5640.8 5645.2 5648.6 5651.3 6103.1 6121.7 6126.7 6130.2 6134.1 5050.5 6172.8 6188.4 6192.3 6198.0 5628.9 5693.3 5695.5 5701.4 5711.6 5282.4 6205.2 6232.4 6258.3 6275.7 6075.4 6087.3 6094.9 6109.0 6109.9 6051.8 6110.3 6122.2 6122.4 6237.2 5038.5 6151.2 6168.4 6168.6 6175.6 6192.9 6195.4 6195.9 6202.3 6208.4 4740.2 4764.5 4888.6 4892.5 4918.4 4340.3 4370.3 4403.9 4448.4 4469.3 5663.3 5666.2 5668.2 5671.0 5673.5 6124.2 6161.9 6168.3 6178.6 6191.1 4763.6 5612.5 5672.9 5684.2 5686.9 4663.7 5308.1 5313.4 5363.6 5371.5 6218.8 6269.5 6287.4 6346.8 6365.2 6258.5 6268.3 6285.5 6288.2 6298.0 6194.0 6304.9 6318.0 6319.2 6324.5 5964.3 5978.5 6036.5 6077.9 6134.0 6228.7 6239.2 6244.4 6244.5 6264.2 5951.9 6053.9 6061.5 6075.1 6085.2 5120.4 5815.1 5888.0 5893.2 5963.1 5749.1 5776.6 5787.7 5787.8 5791.5 5941.4 5983.3 5996.7 6006.1 6009.4 5836.8 5839.6 5847.6 5848.0 5853.8 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:65872.50 Median:34386.66 stddev:148835.56 (432.8%) stddev-sans-first:149172.03 06:32:07 INFO - PROCESS | 1635 | Values: 450.0 465.8 510.0 519.1 552.6 31967.5 33125.0 33172.3 33176.5 34354.8 32739.0 33061.8 33079.0 33116.9 33154.5 6840.8 7230.5 7404.6 7410.7 7453.9 7270.6 7675.2 7706.6 7759.1 7764.7 7718.6 7747.3 7756.8 7756.9 7757.5 7676.3 7698.7 7737.8 7740.3 7745.0 7584.4 7658.5 7659.8 7677.5 7683.7 30908.5 31246.5 31263.7 31301.4 31310.7 3257.3 3283.2 3391.4 3491.4 3502.4 21862.0 21868.6 21921.7 21945.8 22115.0 2724.5 2861.2 2887.2 2935.2 2935.6 474851.0 477991.6 478316.0 478806.0 479173.6 56341.2 56714.7 56726.1 56805.0 56810.7 59461.1 59504.1 59531.0 59573.4 59602.1 15272.0 15509.1 15510.7 15536.0 15541.3 11577.8 11587.5 11596.6 12110.8 12211.5 12678.9 15509.6 15529.8 15570.5 15653.0 6709.5 6712.0 6766.4 6780.4 6804.3 891.4 931.9 934.9 962.5 1066.2 26669.5 28843.1 28917.7 29079.4 29687.6 879.6 990.2 1033.3 1044.6 1088.8 13704.3 15089.9 15465.5 15506.6 15841.8 633793.0 636250.0 636907.0 638594.0 651002.0 51500.5 51722.7 51761.5 51899.7 52030.7 1199.1 1228.3 1285.2 1321.7 1341.3 27701.3 28818.7 29110.6 29170.6 29330.0 35511.6 43624.1 44040.3 44164.3 44255.1 533192.0 534853.0 536209.0 537475.0 538504.0 21451.8 21939.0 22827.2 23243.2 23453.6 39785.8 40109.0 40338.9 40785.8 40818.8 32866.5 33499.2 33691.8 34354.7 34418.5 33318.3 33602.3 33935.0 34172.3 34505.5 34215.8 34674.5 34818.7 34875.3 34992.8 29148.4 30249.5 30465.0 30504.7 30862.4 23016.7 23179.4 23337.4 23534.3 23683.3 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:32418.29 Median:2090.82 stddev:88892.51 (4251.6%) stddev-sans-first:89109.29 06:32:07 INFO - PROCESS | 1635 | Values: 361.7 367.6 367.9 383.1 391.9 15233.1 15809.5 16117.6 16222.4 16229.8 14205.0 17441.0 18200.8 18959.5 19010.4 4775.3 5144.1 5145.5 5146.7 5151.1 3398.9 3610.5 3611.3 4800.2 5011.6 5013.6 5101.9 5113.6 5119.3 5119.8 4850.5 5009.8 5032.5 5072.0 5100.0 4479.7 4487.6 4491.0 4491.7 4505.7 19738.8 20812.0 20842.3 21017.6 21067.0 1975.4 2316.7 2335.0 2440.2 3078.4 8969.8 9104.6 9508.8 9516.8 13295.3 1632.4 1664.3 1713.8 1715.4 1731.6 98212.0 128898.1 130202.0 130355.3 131184.0 10613.7 11094.6 11209.2 11297.4 11566.8 14270.7 14297.0 14303.4 14314.6 14333.5 8000.4 8040.7 8208.2 8217.6 8368.9 8024.8 8093.5 8106.0 8262.6 8293.9 3813.7 4299.1 4322.0 4422.4 4534.5 1654.8 1731.2 1864.0 1897.3 1925.0 711.6 729.3 832.4 867.5 920.6 18696.7 19196.0 20435.9 20482.1 20611.3 736.8 853.0 887.8 935.0 961.9 10167.6 10658.7 10706.5 10750.3 10776.8 487192.0 491146.0 493854.0 570820.0 579658.0 83544.0 131190.0 132901.3 134678.0 136684.3 875.8 964.7 984.2 986.2 989.7 17468.5 17886.1 17962.2 18017.0 18405.4 42446.8 52053.7 55911.0 57695.7 59462.1 79319.0 79564.4 80728.0 81227.6 81959.2 6880.2 7228.1 7263.3 7334.6 7450.4 9782.7 12242.3 12457.6 12631.3 12694.8 9457.8 10247.9 10278.3 11146.6 11248.3 8502.1 10270.5 11072.2 11139.3 11253.0 9890.8 10853.7 11023.7 11196.3 11248.9 7254.6 7284.3 7356.2 7561.4 7574.2 10674.6 10795.4 11037.6 11223.4 11449.7 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5284.96 Median:4991.90 stddev:3018.74 (60.5%) stddev-sans-first:3012.63 06:32:07 INFO - PROCESS | 1635 | Values: 1337.5 1476.3 1479.9 1500.8 1512.9 7650.7 8021.4 8025.0 8025.2 8029.8 7143.6 7384.4 7406.7 7777.3 7948.0 2004.3 2057.9 2059.6 2061.4 2066.5 2054.5 2069.9 2082.7 2084.6 2108.6 1817.5 1888.5 1891.3 1957.2 1995.1 1984.5 2060.8 2062.6 2064.8 2074.3 2057.9 2066.9 2077.8 2078.3 2091.1 7918.9 7948.0 8006.8 8037.3 8045.6 5026.3 5192.1 5205.4 5206.0 5212.1 2757.9 3428.8 3470.0 3534.2 3535.7 977.9 989.0 1001.6 1003.9 1012.4 10872.3 10972.5 11027.5 11044.7 11044.8 4143.8 4291.4 4357.4 4391.5 4404.4 8682.9 8684.5 8696.6 8697.3 8702.8 5034.5 5042.1 5047.2 5050.9 5057.2 4554.6 4692.1 4747.0 4750.2 4750.4 3525.5 3582.6 3583.5 3616.9 3649.3 1109.5 1116.4 1128.6 1131.6 1133.8 673.3 775.6 809.3 836.9 853.6 5142.8 5295.2 5375.0 5540.9 5574.2 387.1 397.6 412.4 415.6 417.2 3509.8 3543.6 3663.5 3692.2 3706.4 9491.7 10051.6 10112.2 10170.0 10205.4 9970.5 10101.0 10214.4 10221.8 10230.9 7535.9 7693.8 7702.6 7823.2 7860.1 5283.5 5470.6 5505.7 5563.6 5666.9 8072.4 9451.5 9467.1 9504.9 9514.3 9255.3 9721.3 9728.0 9736.9 9757.6 6710.6 6795.6 6803.3 6804.7 6812.0 7805.1 7854.1 7877.8 7937.9 7981.2 6955.2 7096.7 7162.9 7202.0 7247.4 6754.5 6754.7 6895.7 7084.0 7152.9 5692.8 6647.1 6789.1 6798.8 6804.8 4671.9 4776.6 4861.0 4898.2 4957.5 4478.1 4540.2 4649.3 4779.3 4787.4 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4250.74 Median:4739.48 stddev:1313.27 (27.7%) stddev-sans-first:1281.79 06:32:07 INFO - PROCESS | 1635 | Values: 229.0 281.3 301.1 304.5 311.2 4741.8 4828.8 4846.5 5237.4 5239.4 3938.4 4279.7 5192.7 5200.8 5218.1 3924.0 3941.8 3971.7 3973.1 3980.1 3246.4 3583.5 3948.6 3948.7 3973.9 3474.7 3847.3 3965.2 3965.3 3973.8 3283.6 3824.9 3941.9 3983.9 3992.5 2780.0 2979.4 3459.4 3462.6 3473.8 4308.8 4765.2 5076.5 5097.9 5146.9 3346.4 3906.4 4190.0 4439.8 4464.4 4743.2 5240.7 5420.5 5429.6 5456.9 3285.9 3494.8 3697.3 3713.5 3721.7 4675.3 4697.6 5537.7 5682.6 5691.5 3240.9 3448.4 3704.7 3767.2 3809.2 3684.6 3847.3 3854.0 3860.5 3868.9 3673.8 4174.1 4390.8 4424.8 4437.2 4441.4 5013.8 5420.4 5425.0 5449.1 1198.7 1229.0 1248.8 1250.5 1251.0 709.9 809.1 830.6 847.2 868.6 4006.3 4183.3 4329.4 4821.8 4914.8 4439.6 4455.0 4478.1 5303.5 5333.7 4482.3 4553.5 4737.1 4882.3 4885.7 2351.5 2448.7 2747.9 2775.4 2791.4 4652.2 4903.2 5083.9 5495.4 5529.2 4546.5 4756.0 5011.8 5344.8 5430.7 4907.9 5029.5 5055.7 5513.6 5523.7 4967.9 5254.5 5300.3 5302.0 5394.9 4653.3 4790.4 5086.2 5187.1 5195.5 5086.3 5798.3 5809.2 5833.8 5856.9 3129.9 3148.0 3329.7 3637.4 3757.9 4719.5 4729.9 5247.4 5642.9 5694.1 4774.4 5001.3 5365.9 5459.8 5478.4 4801.4 5001.2 5435.4 5460.9 5471.2 4665.5 5107.6 5199.0 5249.5 5347.1 5145.3 5429.5 5431.0 5444.5 5453.7 4824.6 4841.3 5322.0 5350.2 5352.0 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:18968.49 Median:614.11 stddev:28315.53 (4610.9%) stddev-sans-first:28361.58 06:32:07 INFO - PROCESS | 1635 | Values: 656.8 736.2 769.8 783.0 788.4 12941.0 13394.3 13398.7 13421.9 13434.5 12446.9 12566.1 12570.3 12577.2 12579.8 631.4 650.8 783.3 812.8 828.7 810.3 827.9 828.4 830.6 831.1 866.9 868.8 872.5 872.6 873.3 678.0 698.0 859.8 861.8 862.6 619.7 626.3 633.7 634.5 637.9 11852.3 11901.9 11909.9 11913.7 11930.3 10401.5 10588.9 10619.4 10714.4 11029.6 9123.6 9157.0 9213.4 9454.1 9470.9 3008.4 3021.3 3045.1 3134.1 3140.2 71002.6 72025.6 84517.7 85859.6 93069.5 8322.3 8325.5 8461.3 8479.7 8647.7 17255.5 17364.7 17407.7 17417.7 17426.8 6937.6 7259.9 7345.8 7374.0 7649.0 4119.3 4169.9 4181.9 4185.0 4212.3 2714.5 3266.5 3336.9 3339.6 3341.1 525.3 621.1 634.2 635.5 641.5 514.5 578.6 590.5 612.7 617.6 8239.0 8252.6 8293.3 8300.4 8488.4 535.9 577.8 591.6 594.1 615.5 3850.4 3954.1 4012.0 4052.1 4070.5 68650.6 74975.9 103977.5 107262.0 113093.4 73235.0 92538.0 96192.0 96193.6 98544.5 79820.8 81224.2 82597.6 87043.6 88651.6 6849.7 8398.5 8599.4 8697.9 8712.3 42298.6 51461.0 52191.5 53343.7 55571.2 68995.7 70847.6 75211.0 78670.0 79805.6 11268.5 11548.8 11587.8 11592.9 11618.9 12084.5 12134.8 12243.6 12505.6 12957.2 11493.1 11664.9 12044.3 12181.1 12270.9 11675.6 11791.4 11942.6 12220.4 12262.4 9256.4 11509.3 11541.1 11995.7 12025.9 9326.0 9682.0 9720.3 9954.2 10138.5 8970.9 10176.3 10264.2 10276.2 10335.6 06:32:07 INFO - PROCESS | 1635 | -------- Summary: end -------- 06:32:07 INFO - PROCESS | 1635 | 06:32:07 INFO - TEST-INFO | 1635: exit 0 06:32:07 INFO - TEST-OK | dromaeo_css | took 1120710ms 06:32:07 INFO - TEST-START | kraken 06:32:07 INFO - operating with platform_type : mac_ 06:32:07 INFO - Initialising browser for kraken test... 06:32:07 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp12CwF7/profile http://localhost:49241/getInfo.html) 06:32:09 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 06:32:09 INFO - PROCESS | 1648 | colorDepth:24 06:32:09 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 06:32:09 INFO - PROCESS | 1648 | __metrics 06:32:09 INFO - PROCESS | 1648 | 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" 06:32:09 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:32:10 INFO - TEST-INFO | 1648: exit 0 06:32:10 INFO - Browser initialized. 06:32:10 INFO - Running cycle 1/1 for kraken test... 06:32:10 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/T/tmp12CwF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:22 INFO - PROCESS | 1649 | RSS: Main: 238141440 06:32:22 INFO - PROCESS | 1649 | 06:32:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:32:26 INFO - PROCESS | 1649 | RSS: Main: 288768000 06:32:26 INFO - PROCESS | 1649 | 06:32:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:32:29 INFO - PROCESS | 1649 | RSS: Main: 289308672 06:32:29 INFO - PROCESS | 1649 | 06:32:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:32:33 INFO - PROCESS | 1649 | RSS: Main: 380203008 06:32:33 INFO - PROCESS | 1649 | 06:32:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:32:36 INFO - PROCESS | 1649 | RSS: Main: 281772032 06:32:36 INFO - PROCESS | 1649 | 06:32:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:32:38 INFO - PROCESS | 1649 | RSS: Main: 286769152 06:32:38 INFO - PROCESS | 1649 | 06:32:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:32:42 INFO - PROCESS | 1649 | RSS: Main: 327430144 06:32:42 INFO - PROCESS | 1649 | 06:32:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:32:45 INFO - PROCESS | 1649 | RSS: Main: 329510912 06:32:45 INFO - PROCESS | 1649 | 06:32:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:32:49 INFO - PROCESS | 1649 | RSS: Main: 328876032 06:32:49 INFO - PROCESS | 1649 | 06:32:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:51 INFO - PROCESS | 1649 | RSS: Main: 303845376 06:32:51 INFO - PROCESS | 1649 | 06:32:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:54 INFO - PROCESS | 1649 | RSS: Main: 306470912 06:32:54 INFO - PROCESS | 1649 | 06:32:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:56 INFO - PROCESS | 1649 | RSS: Main: 309620736 06:32:56 INFO - PROCESS | 1649 | 06:32:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:33:00 INFO - PROCESS | 1649 | RSS: Main: 318914560 06:33:00 INFO - PROCESS | 1649 | 06:33:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:33:04 INFO - PROCESS | 1649 | RSS: Main: 319135744 06:33:04 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:33:06 INFO - PROCESS | 1649 | RSS: Main: 362078208 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | __start_tp_report 06:33:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 06:33:06 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 06:33:06 INFO - PROCESS | 1649 | |i|pagename|runs| 06:33:06 INFO - PROCESS | 1649 | |0;ai-astar;113;114;114;111;113;113;114;114;114;113 06:33:06 INFO - PROCESS | 1649 | |1;audio-beat-detection;148;117;116;150;114;113;115;112;143;115 06:33:06 INFO - PROCESS | 1649 | |2;audio-dft;183;181;183;185;185;183;184;246;240;182 06:33:06 INFO - PROCESS | 1649 | |3;audio-fft;79;59;59;88;62;59;58;59;82;57 06:33:06 INFO - PROCESS | 1649 | |4;audio-oscillator;82;69;91;72;69;68;88;67;69;93 06:33:06 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;84;92;130;87;85;87;86;87;84 06:33:06 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;94;97;94;94;94;98;94;94 06:33:06 INFO - PROCESS | 1649 | |7;imaging-desaturate;141;133;86;88;87;86;87;86;82;85 06:33:06 INFO - PROCESS | 1649 | |8;json-parse-financial;56;57;54;54;54;55;55;55;55;55 06:33:06 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;64;71;66;73;74;79;71;71;71;72 06:33:06 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;86;85;86;87;86;91;89;87;89 06:33:06 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;157;161;149;160;162;138;150;148;189;161 06:33:06 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;172;172;177;173;174;180;172;226;238;178 06:33:06 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;76;82;92;91;92;67;67;67;67;68 06:33:06 INFO - PROCESS | 1649 | __end_tp_report 06:33:06 INFO - PROCESS | 1649 | __start_cc_report 06:33:06 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1949 06:33:06 INFO - PROCESS | 1649 | __end_cc_report 06:33:06 INFO - PROCESS | 1649 | __startTimestamp1479393186366__endTimestamp 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | ------- Summary: start ------- 06:33:06 INFO - PROCESS | 1649 | Number of tests: 14 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 06:33:06 INFO - PROCESS | 1649 | Values: 113.0 114.0 114.0 111.0 113.0 113.0 114.0 114.0 114.0 113.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:116.50 stddev:15.82 (13.6%) stddev-sans-first:14.27 06:33:06 INFO - PROCESS | 1649 | Values: 148.0 117.0 116.0 150.0 114.0 113.0 115.0 112.0 143.0 115.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:195.20 Median:184.50 stddev:25.26 (13.7%) stddev-sans-first:26.41 06:33:06 INFO - PROCESS | 1649 | Values: 183.0 181.0 183.0 185.0 185.0 183.0 184.0 246.0 240.0 182.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.86 (19.6%) stddev-sans-first:11.64 06:33:06 INFO - PROCESS | 1649 | Values: 79.0 59.0 59.0 88.0 62.0 59.0 58.0 59.0 82.0 57.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.00 stddev:10.52 (13.7%) stddev-sans-first:10.99 06:33:06 INFO - PROCESS | 1649 | Values: 82.0 69.0 91.0 72.0 69.0 68.0 88.0 67.0 69.0 93.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:87.00 stddev:13.92 (16.0%) stddev-sans-first:14.70 06:33:06 INFO - PROCESS | 1649 | Values: 87.0 84.0 92.0 130.0 87.0 85.0 87.0 86.0 87.0 84.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.00 stddev:1.49 (1.6%) stddev-sans-first:1.56 06:33:06 INFO - PROCESS | 1649 | Values: 94.0 94.0 94.0 97.0 94.0 94.0 94.0 98.0 94.0 94.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:86.00 stddev:21.70 (25.2%) stddev-sans-first:15.80 06:33:06 INFO - PROCESS | 1649 | Values: 141.0 133.0 86.0 88.0 87.0 86.0 87.0 86.0 82.0 85.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 06:33:06 INFO - PROCESS | 1649 | Values: 56.0 57.0 54.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:4.10 (5.7%) stddev-sans-first:3.43 06:33:06 INFO - PROCESS | 1649 | Values: 64.0 71.0 66.0 73.0 74.0 79.0 71.0 71.0 71.0 72.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.94 06:33:06 INFO - PROCESS | 1649 | Values: 87.0 86.0 85.0 86.0 87.0 86.0 91.0 89.0 87.0 89.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:160.50 stddev:13.51 (8.4%) stddev-sans-first:14.33 06:33:06 INFO - PROCESS | 1649 | Values: 157.0 161.0 149.0 160.0 162.0 138.0 150.0 148.0 189.0 161.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:177.50 stddev:24.46 (13.8%) stddev-sans-first:25.40 06:33:06 INFO - PROCESS | 1649 | Values: 172.0 172.0 177.0 173.0 174.0 180.0 172.0 226.0 238.0 178.0 06:33:06 INFO - PROCESS | 1649 | 06:33:06 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:79.00 stddev:11.32 (14.3%) stddev-sans-first:12.00 06:33:06 INFO - PROCESS | 1649 | Values: 76.0 82.0 92.0 91.0 92.0 67.0 67.0 67.0 67.0 68.0 06:33:06 INFO - PROCESS | 1649 | -------- Summary: end -------- 06:33:06 INFO - PROCESS | 1649 | 06:33:07 INFO - TEST-INFO | 1649: exit 0 06:33:07 INFO - TEST-OK | kraken | took 59563ms 06:33:07 INFO - SUITE-END | took 1180s 06:33:07 INFO - Completed test suite (00:19:40) 06:33:07 INFO - javascript benchmark 06:33:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2986.7306394782213, 3314.988928376845, 3330.7168890644302, 3345.9163520911975, 3383.9323213535713, 5501.147322165066, 5539.584531160159, 5638.661680299185, 5695.658260504368, 5713.143028545715, 5643.830685079454, 5649.322081350233, 5721.31344238692, 5725.255716756827, 5740.540756739471, 5026.271190677349, 5047.192449208127, 5076.44159142494, 5130.769115389817, 5149.0731668299695, 5213.635045546814, 5234.895302093956, 5235.947640523584, 5246.344206974129, 5319.20211968204, 5109.540141387293, 5217.295665085203, 5242.6330156889035, 5247.816326428595, 5334.146536554152, 5130.333056702605, 5193.039287731744, 5194.610404219661, 5195.610329225286, 5201.479852014806, 5080.466551012164, 5149.330587023663, 5154.046501397216, 5170.767315470813, 5183.766730497136, 5639.68981706006, 5640.830775076754, 5645.237892884449, 5648.576356773258, 5651.2935883014625, 6103.102203373851, 6121.737397888052, 6126.731429653759, 6130.184124957599, 6134.142567655225, 5050.494950504957, 6172.753089876444, 6188.443040126365, 6192.349803270637, 6198.0, 5628.887422251573, 5693.259876216065, 5695.487406133427, 5701.4013528579735, 5711.600187986843, 5282.445343238982, 6205.162303089025, 6232.376762323732, 6258.3428739982555, 6275.6862156891975, 6075.392460753889, 6087.29996050451, 6094.939050609526, 6109.0, 6109.908351374733, 6051.7579296827635, 6110.315755985069, 6122.234720659918, 6122.448979591858, 6237.189165408558, 5038.521340472649, 6151.200343955257, 6168.414000669929, 6168.629882207082, 6175.5677102602385, 6192.907106393408, 6195.411435913581, 6195.938040619626, 6202.317745048041, 6208.379162083756, 4740.217864052462, 4764.547368000104, 4888.560029597354, 4892.510748925079, 4918.43438004634, 4340.305551111807, 4370.278903980871, 4403.911921761611, 4448.354988526646, 4469.329600559942, 5663.348714897757, 5666.235058267163, 5668.206451096849, 5670.971645141748, 5673.461021202979, 6124.197855633957, 6161.921663708833, 6168.321484636686, 6178.62928224308, 6191.133241346215, 4763.618910487153, 5612.494875461228, 5672.8865422691315, 5684.175794509855, 5686.857828554236, 4663.720176789404, 5308.0710875596615, 5313.388960269541, 5363.570914326844, 5371.462853714597, 6218.81343559694, 6269.529785266214, 6287.371262873768, 6346.8413289667205, 6365.172527571386, 6258.499320054476, 6268.279147897868, 6285.497160227263, 6288.245410550763, 6298.02380631003, 6194.0, 6304.936950630435, 6317.96841015792, 6319.178506794087, 6324.4940404766585, 5964.254468191476, 5978.521718262616, 6036.456718895321, 6077.939220607737, 6134.04922237054, 6228.719707613078, 6239.1577137085915, 6244.375562443901, 6244.469220116341, 6264.154339164154, 5951.92865284253, 6053.940560402, 6061.484773794101, 6075.058365953284, 6085.2393450818645, 5120.436751957356, 5815.127730840408, 5887.970560147171, 5893.2044174035955, 5963.105534169909, 5749.108888122348, 5776.624519406225, 5787.710614469344, 5787.797427090031, 5791.53667706574, 5941.435563621449, 5983.311919129182, 5996.730147143477, 6006.099085137264, 6009.36901625323, 5836.824895253149, 5839.620424672383, 5847.5906686533235, 5847.970760146172, 5853.765849365977], "value": 5614.147135679297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.9662525310602, 465.7717718318021, 510.00803437314426, 519.0656817728091, 552.6131707804537, 31967.52048719268, 33125.00624981248, 33172.33655326895, 33176.50235246473, 34354.828225858895, 32739.0, 33061.834690826574, 33079.0, 33116.85389887963, 33154.50268245972, 6840.837057700203, 7230.457715671332, 7404.62976851158, 7410.666520006613, 7453.888191677102, 7270.636468176596, 7675.15573286938, 7706.6146692665425, 7759.107702614215, 7764.650590723431, 7718.575478348688, 7747.264009919077, 7756.806079847993, 7756.883646745303, 7757.49576277543, 7676.270754278335, 7698.692052317929, 7737.767866964, 7740.26467485588, 7744.993150890405, 7584.393248540104, 7658.540487570764, 7659.808504787425, 7677.539347639159, 7683.7310694126, 30908.536371954215, 31246.53130203049, 31263.687363126304, 31301.37397252065, 31310.686893131005, 3257.2833976525126, 3283.228441316289, 3391.406503861814, 3491.423915054013, 3502.352064867982, 21862.01620927062, 21868.562628747335, 21921.671174932388, 21945.780542194534, 22115.0, 2724.455108978212, 2861.1702606244166, 2887.2493151780686, 2935.222166125978, 2935.6036935013713, 474851.0, 477991.61004195106, 478316.0, 478806.0, 479173.60413198057, 56341.15488267679, 56714.71642641843, 56726.14910776342, 56805.0, 56810.71594642, 59461.108083378786, 59504.107438388455, 59531.0, 59573.40426595765, 59602.105968410506, 15272.0, 15509.146996915053, 15510.689786204213, 15536.0, 15541.300641471162, 11577.826332605018, 11587.478563464665, 11596.594119205787, 12110.81833772494, 12211.450484728208, 12678.936605316914, 15509.612259693373, 15529.767053494206, 15570.496638256302, 15653.0, 6709.463242940553, 6712.0, 6766.4248538874745, 6780.355866192704, 6804.251532331439, 891.416122439803, 931.9207867331353, 934.8878134623889, 962.4562122400821, 1066.1540671895043, 26669.466610667678, 28843.134705958855, 28917.69870355839, 29079.41841163165, 29687.554686679716, 879.5953861223909, 990.1929927109383, 1033.3489901362093, 1044.5978298355187, 1088.8149014667526, 13704.314784260747, 15089.924550377398, 15465.536033919001, 15506.612334691723, 15841.841581584036, 633793.0, 636250.0, 636907.0, 638594.0, 651002.0, 51500.48499515032, 51722.74138629283, 51761.48238517567, 51899.74050129801, 52030.73984630052, 1199.1006744941294, 1228.2875931959443, 1285.1967520299813, 1321.7224382879704, 1341.2958196946681, 27701.30746731348, 28818.711812881604, 29110.557938197686, 29170.56244156382, 29329.973450929116, 35511.644883550834, 43624.12751744884, 44040.339394909744, 44164.337534936356, 44255.11489770251, 533192.0, 534853.0, 536209.0, 537475.0, 538504.0, 21451.78548214498, 21939.0, 22827.20104796324, 23243.186488472824, 23453.648195277427, 39785.83319585469, 40109.0, 40338.853515829156, 40785.77642670725, 40818.79590602028, 32866.50700239451, 33499.162520936196, 33691.83154084214, 34354.656453436146, 34418.48372274468, 33318.333633326714, 33602.32795344129, 33935.0, 34172.31655366928, 34505.482417763254, 34215.82892085524, 34674.47988280127, 34818.65181348154, 34875.30249394947, 34992.82503587466, 29148.417031659672, 30249.546256805726, 30465.0, 30504.694953051072, 30862.382752345275, 23016.654750178426, 23179.4205144866, 23337.41656458602, 23534.29397118089, 23683.289501314986], "value": 17683.655885246808, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7449697962936, 367.5570937020888, 367.93377192105424, 383.1436689240628, 391.9216156768645, 15233.086014839117, 15809.525714228577, 16117.597060073489, 16222.432214872482, 16229.756553651676, 14205.0, 17441.0, 18200.817991820077, 18959.52601184971, 19010.429687109376, 4775.259834725614, 5144.1254986652175, 5145.485451454862, 5146.665466744649, 5151.098557752397, 3398.915027124317, 3610.530631017964, 3611.259691763182, 4800.207965685658, 5011.624128190382, 5013.5989120870245, 5101.948980510185, 5113.642045056848, 5119.334486516747, 5119.820806271781, 4850.490698476645, 5009.77614620327, 5032.547070763649, 5071.96024814912, 5100.0, 4479.686421950465, 4487.551244875519, 4490.955090449119, 4491.663125265618, 4505.707129036602, 19738.80261197384, 20812.0, 20842.27052053186, 21017.579648406947, 21067.0, 1975.3580086471811, 2316.7219933607907, 2334.9533009339716, 2440.1947357372023, 3078.4304903592906, 8969.775755606097, 9104.590293436811, 9508.804264890967, 9516.809663806755, 13295.3352332383, 1632.428649972512, 1664.2594045649691, 1713.8200488948605, 1715.3567412220418, 1731.5584525945928, 98212.0, 128898.06652900214, 130202.0, 130355.34822325828, 131184.0, 10613.734656633645, 11094.611688590861, 11209.159313051554, 11297.435128243555, 11566.826497602542, 14270.714585708227, 14297.0, 14303.356348964322, 14314.570562883131, 14333.498327558485, 8000.439969202216, 8040.678372865137, 8208.231006892209, 8217.630206640715, 8368.874466883002, 8024.759257222293, 8093.514389136671, 8106.0, 8262.586870656443, 8293.875591866126, 3813.7033408641196, 4299.14017196562, 4322.0, 4422.358757980075, 4534.546545345439, 1654.793150856143, 1731.2036463227057, 1863.9720404193947, 1897.297999740105, 1924.9903750481158, 711.6441779110445, 729.2598013016792, 832.3840358134937, 867.5271976772548, 920.581135583308, 18696.719549206773, 19196.040197990045, 20435.897820510803, 20482.078306476244, 20611.278605248743, 736.7642354446525, 852.9914700853036, 887.8135591525852, 934.9859752103724, 961.9178424272693, 10167.593296268215, 10658.680239592824, 10706.464676766287, 10750.301230419998, 10776.838347424795, 487192.0, 491146.0, 493854.0, 570820.0, 579658.0, 83544.0, 131190.0, 132901.33549332386, 134678.0, 136684.31657841845, 875.7679215008028, 964.7202311329776, 984.17329443268, 986.1863962231188, 989.7129832348683, 17468.515176210163, 17886.105694715472, 17962.19170137373, 18017.009064501577, 18405.355812546495, 42446.787766060974, 52053.7397313011, 55911.0, 57695.7115214438, 59462.10806837987, 79319.0, 79564.43588190305, 80728.0, 81227.5938620303, 81959.18040819754, 6880.243173251039, 7228.060352154186, 7263.309985551364, 7334.633268336668, 7450.366718828744, 9782.706518804447, 12242.265464072185, 12457.626271211879, 12631.305278209788, 12694.809577856155, 9457.763555910882, 10247.897521024992, 10278.280520363802, 11146.554137834395, 11248.26886252391, 8502.131530153889, 10270.486475676336, 11072.224944253825, 11139.33164010162, 11253.0, 9890.75273118149, 10853.728656783327, 11023.6850261446, 11196.272242304223, 11248.94375528117, 7254.637268136466, 7284.271572842674, 7356.190819010012, 7561.357284630868, 7574.204708505748, 10674.62638807638, 10795.352278863293, 11037.633521775935, 11223.38271395081, 11449.713757156138], "value": 8869.420726946928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.4516448256213, 1476.2544914818022, 1479.874210692091, 1500.7523758579835, 1512.9394824207031, 7650.693972241111, 8021.4384993050435, 8024.996875390576, 8025.197480251972, 8029.799255018627, 7143.607101609409, 7384.372328352083, 7406.740764073258, 7777.261160189787, 7947.960260198705, 2004.2584243829767, 2057.9485512862225, 2059.6292667319876, 2061.391889392633, 2066.493709041287, 2054.4555692741437, 2069.9172033118657, 2082.6980087887246, 2084.551821358408, 2108.5677436125557, 1817.463848164788, 1888.4806678163545, 1891.2718603337746, 1957.1779852462, 1995.1321175288724, 1984.464194667439, 2060.763012253595, 2062.6390381683145, 2064.834813214939, 2074.3258441006656, 2057.86623869448, 2066.9379918602467, 2077.7714451410334, 2078.3453212238096, 2091.1321801452377, 7918.920810791934, 7948.0, 8006.839863202703, 8037.316828069621, 8045.637946292431, 5026.346574945271, 5192.1173400522, 5205.401378841444, 5205.973970130163, 5212.113940630102, 2757.8621068946472, 3428.8457019434186, 3469.9653003469894, 3534.169470174507, 3535.717142628609, 977.8582105594649, 989.0, 1001.5943542865151, 1003.914667253277, 1012.4229189362067, 10872.293300935493, 10972.506237219344, 11027.503762330714, 11044.668659940215, 11044.791041791594, 4143.834246630101, 4291.356296555542, 4357.368181613649, 4391.473023237232, 4404.383386325917, 8682.913170868336, 8684.478931264144, 8696.565171741388, 8697.347698922606, 8702.82594348122, 5034.471380505068, 5042.092423363756, 5047.242913562922, 5050.873728156752, 5057.241413787961, 4554.590086892129, 4692.085043416501, 4746.95253047472, 4750.168720473903, 4750.406199225097, 3525.453554699026, 3582.5880023797076, 3583.480395342661, 3616.909577260537, 3649.2883887641656, 1109.5187924121387, 1116.3525155409843, 1128.6275529075385, 1131.643532287327, 1133.7789131119519, 673.3468535520537, 775.5501808950795, 809.3484744780508, 836.9121242269596, 853.620139038122, 5142.845714628567, 5295.232191332235, 5375.0, 5540.86147846299, 5574.219609254707, 387.0555843741262, 397.63616291093325, 412.43496409918606, 415.5532802237607, 417.2114703210934, 3509.824508774551, 3543.5924868639922, 3663.505426767352, 3692.2430901665093, 3706.369917114097, 9491.715248542554, 10051.64819231338, 10112.241581881388, 10170.0, 10205.38767673927, 9970.501474926225, 10101.0, 10214.38713677167, 10221.795564088825, 10230.897691022994, 7535.886961695579, 7693.807654808675, 7702.576358300347, 7823.178566250462, 7860.135385107634, 5283.524482796567, 5470.617056805985, 5505.697186654773, 5563.554915606823, 5666.886662266814, 8072.354211663171, 9451.480168590793, 9467.053294670477, 9504.85742713846, 9514.33399662017, 9255.25957923378, 9721.319507634398, 9727.951360243154, 9736.853947190657, 9757.609695612096, 6710.563813352116, 6795.626240556817, 6803.319668033157, 6804.659767011531, 6812.0, 7805.063392392949, 7854.1360450349275, 7877.7636670899965, 7937.920620793718, 7981.201879812204, 6955.23492415844, 7096.716131354688, 7162.89255661155, 7201.963990180016, 7247.420206383582, 6754.459643228432, 6754.6622668865375, 6895.689693963684, 7083.964580177066, 7152.892706609509, 5692.829215123553, 6647.135872336566, 6789.11741473625, 6798.76204332846, 6804.761833336008, 4671.906561868675, 4776.5701086902345, 4861.0, 4898.21628539432, 4957.454679985271, 4478.126765280739, 4540.151371618246, 4649.3026046093355, 4779.330893674958, 4787.449443313924], "value": 4133.6018906069285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [228.9610766169751, 281.30237012209733, 301.06519257704826, 304.4717415284481, 311.18469609622775, 4741.834035808747, 4828.830990915319, 4846.491118432562, 5237.402592209374, 5239.371275446952, 3938.4289278054734, 4279.679024073192, 5192.676686920374, 5200.765965531551, 5218.060749065166, 3924.0, 3941.822617982183, 3971.721979461439, 3973.092915400595, 3980.1044764927806, 3246.399416108016, 3583.4624806279135, 3948.605139486043, 3948.6771931403014, 3973.9205215895663, 3474.6699063589044, 3847.3459511882907, 3965.235470215755, 3965.325894597925, 3973.8211780469946, 3283.5731354923705, 3824.934535350907, 3941.896269044672, 3983.9004024899464, 3992.540857801361, 2779.984511229363, 2979.433907557579, 3459.446488561843, 3462.5844898612327, 3473.808940508271, 4308.836614114203, 4765.237561990065, 5076.543111120017, 5097.898042039175, 5146.9485305146845, 3346.397648423283, 3906.433567132778, 4189.973456503176, 4439.844605438827, 4464.352668863029, 4743.1738780569385, 5240.68555886648, 5420.539254163361, 5429.619926605139, 5456.863578410532, 3285.8663761002417, 3494.790312581253, 3697.334479793636, 3713.498677678506, 3721.7062899334283, 4675.322078298662, 4697.647676424213, 5537.695426751487, 5682.602217844753, 5691.51622112121, 3240.946692325004, 3448.3965306071336, 3704.7036237100965, 3767.246550689873, 3809.2000679857542, 3684.631536846294, 3847.3459511883048, 3853.9807300963316, 3860.4981352424006, 3868.903277418031, 3673.834677439522, 4174.08170202555, 4390.846320378771, 4424.75663838492, 4437.245668236407, 4441.444819397575, 5013.846815232517, 5420.395437034407, 5425.0, 5449.073657478239, 1198.670365649436, 1229.0045063498594, 1248.8376511053505, 1250.474800583739, 1250.974980500403, 709.907711997437, 809.1261437647445, 830.5805568188026, 847.220557087481, 868.6134670071883, 4006.3189257825657, 4183.267928112568, 4329.437173167468, 4821.807127714922, 4914.8034078637165, 4439.64482841372, 4454.977725111418, 4478.149151661174, 5303.522682958553, 5333.653312534673, 4482.2743243851355, 4553.499115097403, 4737.123632128068, 4882.26765985098, 4885.682430641997, 2351.5179388225374, 2448.6571879936823, 2747.931301717433, 2775.3616668166433, 2791.3858951030743, 4652.18564759744, 4903.166461701519, 5083.923741143886, 5495.41133153813, 5529.170624406291, 4546.476930228345, 4756.0, 5011.824586139541, 5344.759485823147, 5430.67415955044, 4907.852764417074, 5029.5221953914315, 5055.6713813602, 5513.641613295123, 5523.685788526932, 4967.925481117858, 5254.500822421864, 5300.296848607315, 5302.0, 5394.919076213781, 4653.348531205702, 4790.383260638196, 5086.18621020635, 5187.09225885461, 5195.480451954925, 5086.313347698161, 5798.303374266858, 5809.215755873072, 5833.79581714638, 5856.887191433614, 3129.906102816919, 3148.039847846337, 3329.7003269705842, 3637.436197389409, 3757.9248415032093, 4719.504452032487, 4729.9054018920115, 5247.4227834937365, 5642.915356269577, 5694.092479019409, 4774.448304301047, 5001.2992983788345, 5365.873166634894, 5459.836204913859, 5478.424765399735, 4801.447833499193, 5001.24981252815, 5435.429279925551, 5460.918086228789, 5471.151971444432, 4665.486796452456, 5107.565856902205, 5198.989854062498, 5249.47505249472, 5347.117725575236, 5145.279660847409, 5429.457054294539, 5431.0, 5444.537214336668, 5453.672779633076, 4824.587706146926, 4841.322214889989, 5322.042032434199, 5350.2242174885205, 5352.036633405869], "value": 3831.9105484034494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8456412743006, 736.1718067174429, 769.8375453065869, 782.9569373684449, 788.428389417672, 12941.0, 13394.263315517643, 13398.66503337417, 13421.859141972931, 13434.46262149514, 12446.937765311184, 12566.057545684087, 12570.30863302518, 12577.18248313859, 12579.811302830465, 631.4222486424916, 650.8307839961597, 783.3224261014238, 812.8293058457731, 828.693383448125, 810.3112354498659, 827.8840962265258, 828.4035494443991, 830.622066959535, 831.0899564976341, 866.9176428239307, 868.8436081505326, 872.4590753732695, 872.6116877989298, 873.3100850328233, 677.9864402711918, 697.9965100174467, 859.7893516088536, 861.840559496492, 862.607513581319, 619.6529943231805, 626.2672672972587, 633.6578247746212, 634.4670476799464, 637.8501052252717, 11852.288862668267, 11901.940490297493, 11909.880901190963, 11913.702157446047, 11930.284182949052, 10401.53193106312, 10588.94705526475, 10619.36283822973, 10714.410707411167, 11029.61396351124, 9123.583903412547, 9156.954215228881, 9213.401128926665, 9454.14912657864, 9470.857937130948, 3008.3832814273023, 3021.30509982703, 3045.057269425713, 3134.13811201919, 3140.1678555182893, 71002.64498677525, 72025.63987180083, 84517.73223401654, 85859.57070214608, 93069.53465232698, 8322.292605128632, 8325.458845175044, 8461.323094152453, 8479.745607631781, 8647.697330593399, 17255.482335529956, 17364.739528907077, 17407.651846963243, 17417.738733918748, 17426.780125391102, 6937.583744975318, 7259.89110163348, 7345.816354591071, 7374.041374621373, 7649.005629268159, 4119.320312148522, 4169.8957526062095, 4181.937270940938, 4184.958150418518, 4212.283911735012, 2714.511387950188, 3266.5100234964943, 3336.9499457508155, 3339.6159441664036, 3341.064501939461, 525.2987262005266, 621.0901029991085, 634.238913304037, 635.5043066408117, 641.5477088652489, 514.4937252623359, 578.6470253145578, 590.5423296944903, 612.6936531734133, 617.5800455690083, 8238.958805205935, 8252.628631711588, 8293.320397192358, 8300.377471689648, 8488.423742432706, 535.8821059366933, 577.7717801468397, 591.6272748168712, 594.1236675903009, 615.5168192968498, 3850.4224366345275, 3954.149857780591, 4011.959880401217, 4052.068024354356, 4070.470838790938, 68650.59722909675, 74975.87536186962, 103977.48011259895, 107262.0, 113093.43453282681, 73235.0, 92538.0, 96192.0, 96193.5570966436, 98544.50727746458, 79820.80268795857, 81224.18775812167, 82597.58701206456, 87043.56478217569, 88651.55674221588, 6849.691763870538, 8398.454100483448, 8599.39804213724, 8697.91302086971, 8712.259457945893, 42298.577014230694, 51461.0, 52191.47808521866, 53343.73328133334, 55571.16643250435, 68995.65502172457, 70847.64576177087, 75211.0, 78670.0, 79805.60097199709, 11268.549258029587, 11548.769024619629, 11587.768244635228, 11592.942035289769, 11618.88381116178, 12084.45619947122, 12134.817977730165, 12243.632691019284, 12505.56230531927, 12957.157784743962, 11493.138014649103, 11664.900317942513, 12044.337561434206, 12181.147319687538, 12270.938645306716, 11675.649730508097, 11791.410429478321, 11942.641720748392, 12220.388980550759, 12262.4481898313, 9256.352055356061, 11509.251898626562, 11541.076713863038, 11995.700107497383, 12025.932250506445, 9325.958901029679, 9682.046975672487, 9720.319577629782, 9954.153896918842, 10138.49307534635, 8970.910290897007, 10176.287659863738, 10264.178865690876, 10276.22928280367, 10335.638252661121], "value": 6680.466508102659, "unit": "score"}], "name": "dromaeo_css", "value": 6733.251918105832, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 111.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 116.0, 150.0, 114.0, 113.0, 115.0, 112.0, 143.0, 115.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 183.0, 185.0, 185.0, 183.0, 184.0, 246.0, 240.0, 182.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 62.0, 59.0, 58.0, 59.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 91.0, 72.0, 69.0, 68.0, 88.0, 67.0, 69.0, 93.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 92.0, 130.0, 87.0, 85.0, 87.0, 86.0, 87.0, 84.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 97.0, 94.0, 94.0, 94.0, 98.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 86.0, 88.0, 87.0, 86.0, 87.0, 86.0, 82.0, 85.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 66.0, 73.0, 74.0, 79.0, 71.0, 71.0, 71.0, 72.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 86.0, 87.0, 86.0, 91.0, 89.0, 87.0, 89.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 149.0, 160.0, 162.0, 138.0, 150.0, 148.0, 189.0, 161.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 177.0, 173.0, 174.0, 180.0, 172.0, 226.0, 238.0, 178.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 92.0, 91.0, 92.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 76.9, "unit": "score"}], "name": "kraken", "value": 1491.6000000000001, "alertThreshold": 2.0}]} 06:33:07 INFO - Return code: 0 06:33:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:33:07 INFO - # TBPL SUCCESS # 06:33:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:33:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:33:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:33:07 INFO - 2016-11-17 06:33:07.713 screenresolution[1653:9825] starting screenresolution argv=screenresolution get 06:33:07 INFO - 2016-11-17 06:33:07.716 screenresolution[1653:9825] Display 0: 1600x1200x32@60 06:33:07 INFO - 2016-11-17 06:33:07.722 screenresolution[1654:9828] starting screenresolution argv=screenresolution list 06:33:07 INFO - Available Modes on Display 0 06:33:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:33:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:33:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:33:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:33:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:33:07 INFO - Intel Iris: 06:33:07 INFO - Chipset Model: Intel Iris 06:33:07 INFO - Type: GPU 06:33:07 INFO - Bus: Built-In 06:33:07 INFO - VRAM (Dynamic, Max): 1536 MB 06:33:07 INFO - Vendor: Intel (0x8086) 06:33:07 INFO - Device ID: 0x0a2e 06:33:07 INFO - Revision ID: 0x0009 06:33:07 INFO - Displays: 06:33:07 INFO - Display: 06:33:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:33:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:33:07 INFO - Display Serial Number: 1600x1200 60 06:33:07 INFO - Main Display: Yes 06:33:07 INFO - Mirror: Off 06:33:07 INFO - Online: Yes 06:33:07 INFO - Rotation: Supported 06:33:07 INFO - Return code: 0 06:33:07 INFO - Running post-action listener: _resource_record_post_action 06:33:07 INFO - [mozharness: 2016-11-17 14:33:07.960793Z] Finished run-tests step (success) 06:33:07 INFO - Running post-run listener: _resource_record_post_run 06:33:08 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37704704; Write bytes: 700248576; Read time: 244; Write time: 2006 06:33:08 INFO - TinderboxPrint: CPU usage
53.5% 06:33:08 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 244 06:33:08 INFO - TinderboxPrint: I/O write bytes / time
700,248,576 / 2,006 06:33:08 INFO - TinderboxPrint: CPU idle
2,260.0 (46.5%) 06:33:08 INFO - TinderboxPrint: CPU system
969.2 (19.9%) 06:33:08 INFO - TinderboxPrint: CPU user
1,632.4 (33.6%) 06:33:08 INFO - TinderboxPrint: Swap in / out
436,072,448 / 0 06:33:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399424000; Write bytes: 399902208; Read time: 29735; Write time: 866 06:33:08 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 34518016; Write bytes: 297096704; Read time: 222; Write time: 1125 06:33:08 INFO - Running post-run listener: _upload_blobber_files 06:33:08 INFO - Blob upload gear active. 06:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:33:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 06:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:33:09 INFO - (blobuploader) - INFO - Done attempting. 06:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:33:10 INFO - (blobuploader) - INFO - Done attempting. 06:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:33:13 INFO - (blobuploader) - INFO - Done attempting. 06:33:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:33:13 INFO - Return code: 0 06:33:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:33:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:33:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d5dbdafb39da4e6b3c2e1eee44948de0a12c91ad8163f232a8e8841e89d4881b98bd0b52c039484918b05cd09a4a3ebda8c2d3281fee6736e4ee79c1d9f4f113", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/de5910bc216ccaa868ed99f0e2b60060195c31e869b2ebfac7b9a0e68533837cb0e041357f80b2df458daf600b32c6ef1e8da590e19aff1133e2203f9c17c9af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3789c6da8d4f691f6890571043cd226bfe933be0da39d866c95ce2f33572b971bfce787640be6e2a8536b0ca584171124e6fb3fe85ad5dfc912923282024bba4"} 06:33:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:33:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:33:13 INFO - Contents: 06:33:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d5dbdafb39da4e6b3c2e1eee44948de0a12c91ad8163f232a8e8841e89d4881b98bd0b52c039484918b05cd09a4a3ebda8c2d3281fee6736e4ee79c1d9f4f113", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/de5910bc216ccaa868ed99f0e2b60060195c31e869b2ebfac7b9a0e68533837cb0e041357f80b2df458daf600b32c6ef1e8da590e19aff1133e2203f9c17c9af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3789c6da8d4f691f6890571043cd226bfe933be0da39d866c95ce2f33572b971bfce787640be6e2a8536b0ca584171124e6fb3fe85ad5dfc912923282024bba4"} 06:33:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:33:13 INFO - Copying logs to upload dir... 06:33:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:33:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.728018 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-17 06:33:13.302141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:33:13.305515) ========= 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.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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/Cedar/sha512/d5dbdafb39da4e6b3c2e1eee44948de0a12c91ad8163f232a8e8841e89d4881b98bd0b52c039484918b05cd09a4a3ebda8c2d3281fee6736e4ee79c1d9f4f113", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/de5910bc216ccaa868ed99f0e2b60060195c31e869b2ebfac7b9a0e68533837cb0e041357f80b2df458daf600b32c6ef1e8da590e19aff1133e2203f9c17c9af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3789c6da8d4f691f6890571043cd226bfe933be0da39d866c95ce2f33572b971bfce787640be6e2a8536b0ca584171124e6fb3fe85ad5dfc912923282024bba4"} build_url:https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010949 build_url: 'https://queue.taskcluster.net/v1/task/ObBlgMd7TJ-Z3-BLexVKjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d5dbdafb39da4e6b3c2e1eee44948de0a12c91ad8163f232a8e8841e89d4881b98bd0b52c039484918b05cd09a4a3ebda8c2d3281fee6736e4ee79c1d9f4f113", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/de5910bc216ccaa868ed99f0e2b60060195c31e869b2ebfac7b9a0e68533837cb0e041357f80b2df458daf600b32c6ef1e8da590e19aff1133e2203f9c17c9af", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3789c6da8d4f691f6890571043cd226bfe933be0da39d866c95ce2f33572b971bfce787640be6e2a8536b0ca584171124e6fb3fe85ad5dfc912923282024bba4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:33:13.346274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:33:13.347019) ========= 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.4TgC8HLd1M/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.BKDsrULyEl/Listeners TMPDIR=/var/folders/vf/0yg7r78j3zz7sn50nkm35wx400000w/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.005350 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:33:13.400018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:33:13.400668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:33:13.401359) ========= ========= Total master_lag: 0.19 =========