builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1475851049.36 results: success (0) buildid: 20161007063359 builduid: 3772910b802d4aa08df7745324d27dcb revision: 1de5e07bed6601d2647e88ed2690b3f30418d8aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.363307) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.363740) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.364027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.386569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.386913) ========= 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.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-10-07 07:37:29-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.15M=0.001s 2016-10-07 07:37:29 (8.15 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.540806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.541122) ========= 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.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.021851 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.589455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:29.589813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1de5e07bed6601d2647e88ed2690b3f30418d8aa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1de5e07bed6601d2647e88ed2690b3f30418d8aa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-10-07 07:37:29,657 truncating revision to first 12 chars 2016-10-07 07:37:29,658 Setting DEBUG logging. 2016-10-07 07:37:29,658 attempt 1/10 2016-10-07 07:37:29,658 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1de5e07bed66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 07:37:29,950 unpacking tar archive at: mozilla-central-1de5e07bed66/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:30.184589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:30.184922) ========= script_repo_revision: 1de5e07bed6601d2647e88ed2690b3f30418d8aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:30.185298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:30.185560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 07:37:30.203457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-07 07:37:30.203734) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:37:30 INFO - MultiFileLogger online at 20161007 07:37:30 in /builds/slave/test 07:37:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:37:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:30 INFO - {'append_to_log': False, 07:37:30 INFO - 'base_work_dir': '/builds/slave/test', 07:37:30 INFO - 'blob_upload_branch': 'Firefox', 07:37:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:30 INFO - 'branch': 'Firefox', 07:37:30 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:30 INFO - 'config_files': ('talos/mac_config.py',), 07:37:30 INFO - 'default_actions': ('clobber', 07:37:30 INFO - 'read-buildbot-config', 07:37:30 INFO - 'download-and-extract', 07:37:30 INFO - 'populate-webroot', 07:37:30 INFO - 'create-virtualenv', 07:37:30 INFO - 'install', 07:37:30 INFO - 'run-tests'), 07:37:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:30 INFO - 'download_minidump_stackwalk': True, 07:37:30 INFO - 'download_symbols': 'ondemand', 07:37:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:30 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:30 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:30 INFO - 'installer_path': 'installer.exe', 07:37:30 INFO - 'log_level': 'info', 07:37:30 INFO - 'log_name': 'talos', 07:37:30 INFO - 'log_to_console': True, 07:37:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:37:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:37:30 INFO - 'opt_config_files': (), 07:37:30 INFO - 'pip_index': False, 07:37:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:30 INFO - 'cmd': ('bash', 07:37:30 INFO - '-c', 07:37:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:30 INFO - 'enabled': True, 07:37:30 INFO - 'halt_on_failure': False, 07:37:30 INFO - 'name': 'check_screen_resolution'},), 07:37:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:30 INFO - 'cmd': ('bash', 07:37:30 INFO - '-c', 07:37:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:30 INFO - 'enabled': True, 07:37:30 INFO - 'halt_on_failure': False, 07:37:30 INFO - 'name': 'check_screen_resolution'},), 07:37:30 INFO - 'run_cmd_checks_enabled': True, 07:37:30 INFO - 'sps_profile': False, 07:37:30 INFO - 'sps_profile_interval': 0, 07:37:30 INFO - 'suite': 'dromaeojs', 07:37:30 INFO - 'system_bits': '32', 07:37:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:30 INFO - 'title': 't-yosemite-r7-0036', 07:37:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:30 INFO - 'use_talos_json': True, 07:37:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:30 INFO - 'work_dir': 'build'} 07:37:30 INFO - [mozharness: 2016-10-07 14:37:30.396090Z] Running clobber step. 07:37:30 INFO - Running pre-action listener: _resource_record_pre_action 07:37:30 INFO - Running main action method: clobber 07:37:30 INFO - rmtree: /builds/slave/test/build 07:37:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:31 INFO - Running post-action listener: _resource_record_post_action 07:37:31 INFO - [mozharness: 2016-10-07 14:37:31.922798Z] Finished clobber step (success) 07:37:31 INFO - [mozharness: 2016-10-07 14:37:31.923032Z] Running read-buildbot-config step. 07:37:31 INFO - Running pre-action listener: _resource_record_pre_action 07:37:31 INFO - Running main action method: read_buildbot_config 07:37:31 INFO - Using buildbot properties: 07:37:31 INFO - { 07:37:31 INFO - "project": "", 07:37:31 INFO - "product": "firefox", 07:37:31 INFO - "script_repo_revision": "production", 07:37:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:37:31 INFO - "repository": "", 07:37:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:37:31 INFO - "buildid": "20161007063359", 07:37:31 INFO - "pgo_build": "False", 07:37:31 INFO - "basedir": "/builds/slave/test", 07:37:31 INFO - "buildnumber": 44, 07:37:31 INFO - "slavename": "t-yosemite-r7-0036", 07:37:31 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:37:31 INFO - "platform": "yosemite_r7", 07:37:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:37:31 INFO - "branch": "mozilla-central", 07:37:31 INFO - "repo_path": "mozilla-central", 07:37:31 INFO - "revision": "1de5e07bed6601d2647e88ed2690b3f30418d8aa", 07:37:31 INFO - "stage_platform": "macosx64", 07:37:31 INFO - "builduid": "3772910b802d4aa08df7745324d27dcb", 07:37:31 INFO - "slavebuilddir": "test" 07:37:31 INFO - } 07:37:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 07:37:31 INFO - Running post-action listener: _resource_record_post_action 07:37:31 INFO - [mozharness: 2016-10-07 14:37:31.927630Z] Finished read-buildbot-config step (success) 07:37:31 INFO - [mozharness: 2016-10-07 14:37:31.927819Z] Running download-and-extract step. 07:37:31 INFO - Running pre-action listener: _resource_record_pre_action 07:37:31 INFO - Running main action method: download_and_extract 07:37:31 INFO - mkdir: /builds/slave/test/build/tests 07:37: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')]} 07:37:31 INFO - trying https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 07:37:31 INFO - Downloading https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 07:37:33 INFO - Downloaded 1199 bytes. 07:37:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:37:33 INFO - Using the following test package requirements: 07:37:33 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:37:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 07:37:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 07:37:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'jsshell-mac.zip'], 07:37:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 07:37:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:37:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 07:37:33 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 07:37:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 07:37:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:37:33 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 07:37:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:37:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:37:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:33 INFO - Fetch https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:37:33 INFO - Http code: 200 07:37:33 INFO - via: 1.1 dc7c4fb5024ff022cad1642ec506a6e8.cloudfront.net (CloudFront) 07:37:33 INFO - x-amz-cf-id: MYvIsiaRa-ROX6HEFSl8omcjp4pqUGXK_ihT3P28cVfUqxZgKuxAIA== 07:37:33 INFO - x-amz-version-id: 4AlI3s0la8z0WJTLZ1gpXeQQmfLOqfkt 07:37:34 INFO - Expected file size: 16482446 07:37:34 INFO - Obtained file size: 16482446 07:37:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:37:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:37:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:40 INFO - Fetch https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:37:41 INFO - Http code: 200 07:37:41 INFO - via: 1.1 4a55d86b7263f73c6817c7c25d4b3643.cloudfront.net (CloudFront) 07:37:41 INFO - x-amz-cf-id: Rsr_w1PNdflLBkK4ziO2uNec0YmH5qwFBBu_7GXgWFQuTEx71yw3dA== 07:37:41 INFO - x-amz-version-id: 4AlI3s0la8z0WJTLZ1gpXeQQmfLOqfkt 07:37:41 INFO - Expected file size: 16482446 07:37:41 INFO - Obtained file size: 16482446 07:37:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 07:37:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:37:48 INFO - Fetch https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 07:37:49 INFO - Http code: 200 07:37:49 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 07:37:49 INFO - x-amz-cf-id: 7z0e4zTIrPC6ADK73ffxTCLxyAA9zx24FpbFS9zGsuzKuq9LbdRpxQ== 07:37:49 INFO - x-amz-version-id: 8BLmwPYaObV6wvtHkqtTobN0iHV4KK0F 07:37:49 INFO - Expected file size: 14409006 07:37:49 INFO - Obtained file size: 14409006 07:37: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')]} 07:37:50 INFO - trying https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:37:50 INFO - Downloading https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 07:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 07:37:54 INFO - Downloaded 111752786 bytes. 07:37:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:37:54 INFO - mkdir: /builds/slave/test/properties 07:37:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:54 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:54 INFO - Contents: 07:37:54 INFO - build_url:https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:37:55 INFO - Running post-action listener: _resource_record_post_action 07:37:55 INFO - Running post-action listener: set_extra_try_arguments 07:37:55 INFO - [mozharness: 2016-10-07 14:37:55.308406Z] Finished download-and-extract step (success) 07:37:55 INFO - [mozharness: 2016-10-07 14:37:55.308547Z] Running populate-webroot step. 07:37:55 INFO - Running pre-action listener: _resource_record_pre_action 07:37:55 INFO - Running main action method: populate_webroot 07:37:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:55 INFO - '--tppagecycles', 07:37:55 INFO - '7'], 07:37:55 INFO - 'tests': ['tsvgm']}}, 07:37:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['damp', 'tps']}, 07:37:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'tests': ['damp', 'tps']}, 07:37:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['dromaeo_dom']}, 07:37:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['basic_compositor_video']}, 07:37:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['a11yr', 07:37:55 INFO - 'ts_paint', 07:37:55 INFO - 'tpaint', 07:37:55 INFO - 'sessionrestore', 07:37:55 INFO - 'sessionrestore_no_auto_restore', 07:37:55 INFO - 'tabpaint']}, 07:37:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['tsvgx', 07:37:55 INFO - 'tsvgr_opacity', 07:37:55 INFO - 'tart', 07:37:55 INFO - 'tscrollx', 07:37:55 INFO - 'cart']}, 07:37:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:55 INFO - 'tsvgr_opacity', 07:37:55 INFO - 'tart', 07:37:55 INFO - 'tscrollx', 07:37:55 INFO - 'cart']}, 07:37:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'talos_options': ['--disable-e10s'], 07:37:55 INFO - 'tests': ['tp5o']}, 07:37:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'tests': ['tp5o']}, 07:37:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'talos_options': ['--disable-e10s', 07:37:55 INFO - '--xperf_path', 07:37:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:55 INFO - 'tests': ['tp5n']}, 07:37:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:55 INFO - 'talos_options': ['--xperf_path', 07:37:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:55 INFO - 'tests': ['tp5n']}}, 07:37:55 INFO - 'talos.zip': {'path': '', 07:37:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:55 INFO - Running post-action listener: _resource_record_post_action 07:37:55 INFO - [mozharness: 2016-10-07 14:37:55.327365Z] Finished populate-webroot step (success) 07:37:55 INFO - [mozharness: 2016-10-07 14:37:55.327503Z] Running create-virtualenv step. 07:37:55 INFO - Running pre-action listener: _resource_record_pre_action 07:37:55 INFO - Running main action method: create_virtualenv 07:37:55 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:55 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 07:37:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:55 INFO - Using real prefix '/tools/python27' 07:37:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:59 INFO - Installing pip.................done. 07:37:59 INFO - Return code: 0 07:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:59 INFO - Reading from file tmpfile_stdout 07:37:59 INFO - Output received: 07:37:59 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) 07:37:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:59 INFO - 'HOME': '/Users/cltbld', 07:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PAGER': '/bin/cat', 07:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:37:59 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - 'XPC_FLAGS': '0x0', 07:37:59 INFO - 'XPC_SERVICE_NAME': '0', 07:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:59 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 07:37:59 INFO - Cleaning up... 07:37:59 INFO - Return code: 0 07:37:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:59 INFO - 'HOME': '/Users/cltbld', 07:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PAGER': '/bin/cat', 07:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:37:59 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - 'XPC_FLAGS': '0x0', 07:37:59 INFO - 'XPC_SERVICE_NAME': '0', 07:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:00 INFO - Downloading/unpacking psutil>=3.1.1 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:04 INFO - Installing collected packages: psutil 07:38:04 INFO - Running setup.py install for psutil 07:38:04 INFO - building 'psutil._psutil_osx' extension 07:38:04 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 07:38:05 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 07:38:05 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 07:38:05 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 07:38:05 INFO - building 'psutil._psutil_posix' extension 07:38:05 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 07:38:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:38:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:38:05 INFO - ^ 07:38:05 INFO - 1 warning generated. 07:38:05 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 07:38:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:05 INFO - Successfully installed psutil 07:38:05 INFO - Cleaning up... 07:38:05 INFO - Return code: 0 07:38:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:05 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')]} 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:05 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')]} 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:05 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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:05 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 07:38:05 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 07:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:05 INFO - 'HOME': '/Users/cltbld', 07:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:05 INFO - 'LOGNAME': 'cltbld', 07:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:05 INFO - 'MOZ_NO_REMOTE': '1', 07:38:05 INFO - 'NO_EM_RESTART': '1', 07:38:05 INFO - 'PAGER': '/bin/cat', 07:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:05 INFO - 'PWD': '/builds/slave/test', 07:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:05 INFO - 'SHELL': '/bin/bash', 07:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:05 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:05 INFO - 'USER': 'cltbld', 07:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:05 INFO - 'XPC_FLAGS': '0x0', 07:38:05 INFO - 'XPC_SERVICE_NAME': '0', 07:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:08 INFO - Installing collected packages: mozsystemmonitor 07:38:08 INFO - Running setup.py install for mozsystemmonitor 07:38:08 INFO - Successfully installed mozsystemmonitor 07:38:08 INFO - Cleaning up... 07:38:08 INFO - Return code: 0 07:38:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:08 INFO - 'HOME': '/Users/cltbld', 07:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:08 INFO - 'LOGNAME': 'cltbld', 07:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:08 INFO - 'MOZ_NO_REMOTE': '1', 07:38:08 INFO - 'NO_EM_RESTART': '1', 07:38:08 INFO - 'PAGER': '/bin/cat', 07:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:08 INFO - 'PWD': '/builds/slave/test', 07:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:08 INFO - 'SHELL': '/bin/bash', 07:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:08 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:08 INFO - 'USER': 'cltbld', 07:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:08 INFO - 'XPC_FLAGS': '0x0', 07:38:08 INFO - 'XPC_SERVICE_NAME': '0', 07:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:08 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:11 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 07:38:11 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 07:38:11 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 07:38:11 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 07:38:11 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 07:38:11 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 07:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:11 INFO - warning: no files found matching '*.txt' 07:38:11 INFO - no previously-included directories found matching 'build' 07:38:11 INFO - no previously-included directories found matching 'dist' 07:38:11 INFO - no previously-included directories found matching '.git*' 07:38:11 INFO - Installing collected packages: jsonschema, functools32 07:38:11 INFO - Running setup.py install for functools32 07:38:12 INFO - warning: no files found matching '*.txt' 07:38:12 INFO - no previously-included directories found matching 'build' 07:38:12 INFO - no previously-included directories found matching 'dist' 07:38:12 INFO - no previously-included directories found matching '.git*' 07:38:12 INFO - Successfully installed jsonschema functools32 07:38:12 INFO - Cleaning up... 07:38:12 INFO - Return code: 0 07:38:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:12 INFO - 'HOME': '/Users/cltbld', 07:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:12 INFO - 'LOGNAME': 'cltbld', 07:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:12 INFO - 'MOZ_NO_REMOTE': '1', 07:38:12 INFO - 'NO_EM_RESTART': '1', 07:38:12 INFO - 'PAGER': '/bin/cat', 07:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:12 INFO - 'PWD': '/builds/slave/test', 07:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:12 INFO - 'SHELL': '/bin/bash', 07:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:12 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:12 INFO - 'USER': 'cltbld', 07:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:12 INFO - 'XPC_FLAGS': '0x0', 07:38:12 INFO - 'XPC_SERVICE_NAME': '0', 07:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:12 INFO - Cleaning up... 07:38:12 INFO - Return code: 0 07:38:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:12 INFO - 'HOME': '/Users/cltbld', 07:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:12 INFO - 'LOGNAME': 'cltbld', 07:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:12 INFO - 'MOZ_NO_REMOTE': '1', 07:38:12 INFO - 'NO_EM_RESTART': '1', 07:38:12 INFO - 'PAGER': '/bin/cat', 07:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:12 INFO - 'PWD': '/builds/slave/test', 07:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:12 INFO - 'SHELL': '/bin/bash', 07:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:12 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:12 INFO - 'USER': 'cltbld', 07:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:12 INFO - 'XPC_FLAGS': '0x0', 07:38:12 INFO - 'XPC_SERVICE_NAME': '0', 07:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:12 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 07:38:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 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 07:38:16 INFO - Downloading docopt-0.6.1.tar.gz 07:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:16 INFO - Running setup.py install for blobuploader 07:38:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:16 INFO - Running setup.py install for requests 07:38:17 INFO - Running setup.py install for docopt 07:38:17 INFO - Successfully installed blobuploader requests docopt 07:38:17 INFO - Cleaning up... 07:38:17 INFO - Return code: 0 07:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:17 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')]} 07:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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')]} 07:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:17 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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:17 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 07:38:17 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 07:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:17 INFO - 'HOME': '/Users/cltbld', 07:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:17 INFO - 'LOGNAME': 'cltbld', 07:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:17 INFO - 'MOZ_NO_REMOTE': '1', 07:38:17 INFO - 'NO_EM_RESTART': '1', 07:38:17 INFO - 'PAGER': '/bin/cat', 07:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:17 INFO - 'PWD': '/builds/slave/test', 07:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:17 INFO - 'SHELL': '/bin/bash', 07:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:17 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:17 INFO - 'USER': 'cltbld', 07:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:17 INFO - 'XPC_FLAGS': '0x0', 07:38:17 INFO - 'XPC_SERVICE_NAME': '0', 07:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:17 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-kHVGFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:17 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vsQHTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:17 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-EQG86C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:17 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-jEqqCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5HTEk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-wIcQva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-3tdLUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1wGlVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KT6Y6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KHiGiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-kGjKcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2g3yZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:18 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IVNKGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:19 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-xNvhTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:19 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-UwlF9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:19 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-gBCFON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:19 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IRKEKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:19 INFO - Running setup.py install for manifestparser 07:38:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:19 INFO - Running setup.py install for mozcrash 07:38:19 INFO - Running setup.py install for mozdebug 07:38:19 INFO - Running setup.py install for mozdevice 07:38:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Running setup.py install for mozfile 07:38:20 INFO - Running setup.py install for mozhttpd 07:38:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Running setup.py install for mozinfo 07:38:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Running setup.py install for mozInstall 07:38:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Running setup.py install for mozleak 07:38:20 INFO - Running setup.py install for mozlog 07:38:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:20 INFO - Running setup.py install for moznetwork 07:38:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Running setup.py install for mozprocess 07:38:21 INFO - Running setup.py install for mozprofile 07:38:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Running setup.py install for mozrunner 07:38:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Running setup.py install for mozscreenshot 07:38:21 INFO - Running setup.py install for moztest 07:38:21 INFO - Running setup.py install for mozversion 07:38:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:21 INFO - Cleaning up... 07:38:22 INFO - Return code: 0 07:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:22 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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:22 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 07:38:22 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 07:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:22 INFO - 'HOME': '/Users/cltbld', 07:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:22 INFO - 'LOGNAME': 'cltbld', 07:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:22 INFO - 'MOZ_NO_REMOTE': '1', 07:38:22 INFO - 'NO_EM_RESTART': '1', 07:38:22 INFO - 'PAGER': '/bin/cat', 07:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:22 INFO - 'PWD': '/builds/slave/test', 07:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:22 INFO - 'SHELL': '/bin/bash', 07:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:22 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:22 INFO - 'USER': 'cltbld', 07:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:22 INFO - 'XPC_FLAGS': '0x0', 07:38:22 INFO - 'XPC_SERVICE_NAME': '0', 07:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IyJzNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:22 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)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-stypLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-fX4B1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:22 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)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-crMk1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:22 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)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-37UzGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:22 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)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DwAODG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:22 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)) 07:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:22 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-frKWJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-15N39k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-jL9Vf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-soU78N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DPFt3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-p9KNQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PKFWvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Qz9PgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vUZi24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Snrrym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:23 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)) 07:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:23 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-WgQ31H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:24 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)) 07:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:24 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)) 07:38:24 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)) 07:38:24 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)) 07:38:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:26 INFO - Downloading blessings-1.6.tar.gz 07:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:26 INFO - Installing collected packages: blessings 07:38:26 INFO - Running setup.py install for blessings 07:38:26 INFO - Successfully installed blessings 07:38:26 INFO - Cleaning up... 07:38:26 INFO - Return code: 0 07:38:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:27 INFO - Reading from file tmpfile_stdout 07:38:27 INFO - Current package versions: 07:38:27 INFO - blessings == 1.6 07:38:27 INFO - blobuploader == 1.2.4 07:38:27 INFO - docopt == 0.6.1 07:38:27 INFO - functools32 == 3.2.3-2 07:38:27 INFO - jsonschema == 2.5.1 07:38:27 INFO - manifestparser == 1.1 07:38:27 INFO - mozInstall == 1.12 07:38:27 INFO - mozcrash == 0.17 07:38:27 INFO - mozdebug == 0.1 07:38:27 INFO - mozdevice == 0.48 07:38:27 INFO - mozfile == 1.2 07:38:27 INFO - mozhttpd == 0.7 07:38:27 INFO - mozinfo == 0.9 07:38:27 INFO - mozleak == 0.1 07:38:27 INFO - mozlog == 3.4 07:38:27 INFO - moznetwork == 0.27 07:38:27 INFO - mozprocess == 0.23 07:38:27 INFO - mozprofile == 0.28 07:38:27 INFO - mozrunner == 6.12 07:38:27 INFO - mozscreenshot == 0.1 07:38:27 INFO - mozsystemmonitor == 0.3 07:38:27 INFO - moztest == 0.7 07:38:27 INFO - mozversion == 1.4 07:38:27 INFO - psutil == 3.1.1 07:38:27 INFO - requests == 1.2.3 07:38:27 INFO - wsgiref == 0.1.2 07:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:27 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 07:38:27 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 07:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:27 INFO - 'HOME': '/Users/cltbld', 07:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:27 INFO - 'LOGNAME': 'cltbld', 07:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:27 INFO - 'MOZ_NO_REMOTE': '1', 07:38:27 INFO - 'NO_EM_RESTART': '1', 07:38:27 INFO - 'PAGER': '/bin/cat', 07:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:27 INFO - 'PWD': '/builds/slave/test', 07:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:27 INFO - 'SHELL': '/bin/bash', 07:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:27 INFO - 'USER': 'cltbld', 07:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:27 INFO - 'XPC_FLAGS': '0x0', 07:38:27 INFO - 'XPC_SERVICE_NAME': '0', 07:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 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)) 07:38:27 INFO - Cleaning up... 07:38:27 INFO - Return code: 0 07:38:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 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 0x108ff2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26a4a3c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, '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.FwBB48QeXx/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.hWx7zGDagv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 07:38:27 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 07:38:27 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 07:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:27 INFO - 'HOME': '/Users/cltbld', 07:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:27 INFO - 'LOGNAME': 'cltbld', 07:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:27 INFO - 'MOZ_NO_REMOTE': '1', 07:38:27 INFO - 'NO_EM_RESTART': '1', 07:38:27 INFO - 'PAGER': '/bin/cat', 07:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:27 INFO - 'PWD': '/builds/slave/test', 07:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:27 INFO - 'SHELL': '/bin/bash', 07:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:38:27 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:27 INFO - 'USER': 'cltbld', 07:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:27 INFO - 'XPC_FLAGS': '0x0', 07:38:27 INFO - 'XPC_SERVICE_NAME': '0', 07:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:27 INFO - Cleaning up... 07:38:27 INFO - Return code: 0 07:38:27 INFO - Running post-action listener: _resource_record_post_action 07:38:27 INFO - Running post-action listener: _start_resource_monitoring 07:38:27 INFO - Starting resource monitoring. 07:38:27 INFO - [mozharness: 2016-10-07 14:38:27.795535Z] Finished create-virtualenv step (success) 07:38:27 INFO - [mozharness: 2016-10-07 14:38:27.796551Z] Running install step. 07:38:27 INFO - Running pre-action listener: _resource_record_pre_action 07:38:27 INFO - Running main action method: install 07:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:28 INFO - Reading from file tmpfile_stdout 07:38:28 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:28 INFO - Reading from file tmpfile_stdout 07:38:28 INFO - Output received: 07:38:28 INFO - Usage: mozinstall [options] installer 07:38:28 INFO - Options: 07:38:28 INFO - -h, --help show this help message and exit 07:38:28 INFO - -d DEST, --destination=DEST 07:38:28 INFO - Directory to install application into. [default: 07:38:28 INFO - "/builds/slave/test"] 07:38:28 INFO - --app=APP Application being installed. [default: firefox] 07:38:28 INFO - mkdir: /builds/slave/test/build/application 07:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:39:03 INFO - Reading from file tmpfile_stdout 07:39:03 INFO - Output received: 07:39:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:39:03 INFO - Running post-action listener: _resource_record_post_action 07:39:03 INFO - [mozharness: 2016-10-07 14:39:03.152315Z] Finished install step (success) 07:39:03 INFO - [mozharness: 2016-10-07 14:39:03.152461Z] Running run-tests step. 07:39:03 INFO - Running pre-action listener: _resource_record_pre_action 07:39:03 INFO - Running main action method: run_tests 07:39:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:39:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:39:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:39:03 INFO - 2016-10-07 07:39:03.167 screenresolution[1934:15348] starting screenresolution argv=screenresolution get 07:39:03 INFO - 2016-10-07 07:39:03.169 screenresolution[1934:15348] Display 0: 1600x1200x32@60 07:39:03 INFO - 2016-10-07 07:39:03.175 screenresolution[1935:15350] starting screenresolution argv=screenresolution list 07:39:03 INFO - Available Modes on Display 0 07:39:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:39:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:39:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:39:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:39:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:39:03 INFO - Intel Iris: 07:39:03 INFO - Chipset Model: Intel Iris 07:39:03 INFO - Type: GPU 07:39:03 INFO - Bus: Built-In 07:39:03 INFO - VRAM (Dynamic, Max): 1536 MB 07:39:03 INFO - Vendor: Intel (0x8086) 07:39:03 INFO - Device ID: 0x0a2e 07:39:03 INFO - Revision ID: 0x0009 07:39:03 INFO - Displays: 07:39:03 INFO - Display: 07:39:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:39:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:39:03 INFO - Display Serial Number: 1600x1200 60 07:39:03 INFO - Main Display: Yes 07:39:03 INFO - Mirror: Off 07:39:03 INFO - Online: Yes 07:39:03 INFO - Rotation: Supported 07:39:03 INFO - Return code: 0 07:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:03 INFO - Python 2.7.3 07:39:03 INFO - Return code: 0 07:39:03 INFO - grabbing minidump binary from tooltool 07:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:39:03 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 0x108e06d30>, '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 0x108c2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dfeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:03 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 07:39:03 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 07:39:03 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 07:39:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:03 INFO - Return code: 0 07:39:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:39:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:39:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 07:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 07:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FwBB48QeXx/Render', 07:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:03 INFO - 'HOME': '/Users/cltbld', 07:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:03 INFO - 'LOGNAME': 'cltbld', 07:39:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:03 INFO - 'MOZ_NO_REMOTE': '1', 07:39:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:03 INFO - 'NO_EM_RESTART': '1', 07:39:03 INFO - 'PAGER': '/bin/cat', 07:39:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:03 INFO - 'PWD': '/builds/slave/test', 07:39:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:03 INFO - 'SHELL': '/bin/bash', 07:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hWx7zGDagv/Listeners', 07:39:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 07:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:03 INFO - 'USER': 'cltbld', 07:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:03 INFO - 'XPC_FLAGS': '0x0', 07:39:03 INFO - 'XPC_SERVICE_NAME': '0', 07:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 07:39:03 INFO - mozversion application_buildid: 20161007063359 07:39:03 INFO - mozversion application_changeset: 1de5e07bed6601d2647e88ed2690b3f30418d8aa 07:39:03 INFO - mozversion application_display_name: Nightly 07:39:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:03 INFO - mozversion application_name: Firefox 07:39:03 INFO - mozversion application_remotingname: firefox 07:39:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:39:03 INFO - mozversion application_vendor: Mozilla 07:39:03 INFO - mozversion application_version: 52.0a1 07:39:03 INFO - mozversion platform_buildid: 20161007063359 07:39:03 INFO - mozversion platform_changeset: 1de5e07bed6601d2647e88ed2690b3f30418d8aa 07:39:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:39:03 INFO - mozversion platform_version: 52.0a1 07:39:03 INFO - using testdate: 1475851143 07:39:03 INFO - actual date: 1475851143 07:39:03 INFO - starting webserver on 'localhost:50903' 07:39:03 INFO - SUITE-START | Running 2 tests 07:39:03 INFO - TEST-START | dromaeo_css 07:39:03 INFO - operating with platform_type : mac_ 07:39:03 INFO - Initialising browser for dromaeo_css test... 07:39:03 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp3LotL5/profile http://localhost:50903/getInfo.html) 07:39:06 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 07:39:06 INFO - PROCESS | 1945 | colorDepth:24 07:39:06 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 07:39:06 INFO - PROCESS | 1945 | __metrics 07:39:06 INFO - PROCESS | 1945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:39:06 INFO - PROCESS | 1945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:07 INFO - TEST-INFO | 1945: exit 0 07:39:07 INFO - Browser initialized. 07:39:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:07 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp3LotL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:19 INFO - PROCESS | 1947 | RSS: Main: 234721280 07:39:19 INFO - PROCESS | 1947 | 07:40:10 INFO - PROCESS | 1947 | 1475851210509 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] 07:42:23 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50903/tests/dromaeo/cssquery-ext.html) 07:42:25 INFO - PROCESS | 1947 | RSS: Main: 444178432 07:42:25 INFO - PROCESS | 1947 | 07:45:28 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-ext.html (next: http://localhost:50903/tests/dromaeo/cssquery-jquery.html) 07:45:29 INFO - PROCESS | 1947 | RSS: Main: 374431744 07:45:29 INFO - PROCESS | 1947 | 07:48:31 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50903/tests/dromaeo/cssquery-mootools.html) 07:48:32 INFO - PROCESS | 1947 | RSS: Main: 340074496 07:48:32 INFO - PROCESS | 1947 | 07:51:34 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50903/tests/dromaeo/cssquery-prototype.html) 07:51:35 INFO - PROCESS | 1947 | RSS: Main: 328585216 07:51:35 INFO - PROCESS | 1947 | 07:54:38 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50903/tests/dromaeo/cssquery-yui.html) 07:54:39 INFO - PROCESS | 1947 | RSS: Main: 328458240 07:54:39 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-yui.html (next: http://localhost:50903/tests/dromaeo/cssquery-dojo.html) 07:57:43 INFO - PROCESS | 1947 | RSS: Main: 406417408 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | __start_tp_report 07:57:43 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 07:57:43 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 07:57:43 INFO - PROCESS | 1947 | |i|pagename|runs| 07:57:43 INFO - PROCESS | 1947 | |0;dojo.html;3323.933521329573;3337.516060171275;3351.48052051932;3378.3918894598964;3406.6082400523933;5583.609147359686;5692.203091567184;5722.055860782976;5839.416058394158;5909.497692696115;5702.800401985931;5724.084146536555;5770.480656740892;5816.360200377955;5843.444872737083;5131.563817075553;5161.251618515313;5189.6107791915565;5221.634485586011;5248.8425347239645;4831.903361932759;5346;5369.677819330833;5380.973095134519;5429.484199001088;5302.708351040691;5336.946630533684;5354.759035843396;5374.892502149954;5413.458654134574;5134.948650513522;5160.767765450526;5220.817271395521;5221.556167725748;5263.105272103751;5170.870728231786;5194.117000109953;5196.948030519684;5243.449437809051;5286.5242128208265;5756.884862302731;5764.135379693038;5773.509251713609;5801.0428279333855;5842.298924129132;6095.420935011167;6108.493847774667;6121.940772763084;6223.688815559204;6252.531060170505;5575.8884822303735;5990.131430942489;6186.690665466754;6196.411340922605;6238.625682459067;5896.705164741746;5902.940970590282;5909.054551271776;5916.497097746654;5918.496927761103;6187.752489900354;6240.656763878031;6299.307076221612;6362.2683391409655;6364.459020983269;6124.081387791778;6124.564025909317;6140.114146351208;6189.257289125334;6201.162843016135;6234.875302493925;6244.2819075805955;6257;6268.843278917972;6282.528810339243;5994.790182343597;6101.938980610137;6195.690215489208;6202.782902598477;6212.81361559154;6095.3042442883725;6172.629642221481;6182.443580077815;6183;6186.288576813724;4911.778969946361;4942.258661200849;4954.801807927714;4965.0069986002945;5008.774605142778;4414.779261036935;4523.140603285366;4540.750258735801;4543.954560454419;4586.908261834745;5769.9711501442225;5813.069908814569;5830.183774271605;5839.591228613956;5851.707414629337;6140.17107690456;6241.906371404432;6248.4376406123665;6265.216847894013;6274.498040156776;5712.028955077647;5782.797602083907;5793.275840519935;5795.391483894215;5803.419658034247;5380.704061276668;5411.594130440233;5421.593380496479;5430.51125398716;5431.402545719968;6313.526485513697;6344.143540621957;6346.968265158737;6374.26695929974;6444.709988050456;6242.906356404748;6257.655828929453;6263.843403914939;6275.874482510233;6284.905726414016;6441.67791610427;6441.774537891151;6448.806535803933;6450.3549645037;6458.580192287674;6070.817875463743;6097.796915383898;6104.0347610180015;6111.682900513672;6181.629102253879;5409.29679141709;6207.379262073757;6234.2830574484515;6237.5009999200865;6251.124842521959;6144.354842741448;6166.568340216321;6172.6913654318005;6187.133801267916;6189.164462797465;5215.687058776485;6015.969920150371;6154.415330543591;6162.352952939877;6170.876582468236;4875.731834749123;5750;5835.6498610081835;5906.0255057914965;5920.644761314335;6078.696065196634;6103.277060575968;6105.45050945417;6122.938770612415;6144.187464698014;5009.273655320031;6000.309964354155;6051.062085376773;6071.058985857199;6129.84675383119 07:57:43 INFO - PROCESS | 1947 | |1;ext.html;450.8331917190639;469.58441779025554;517.6816258001328;533.5411546070379;553.6518577264361;40500.797496012514;42119;42251;44253.89365265862;44299.77850110753;42996.92507687309;43450.34824477635;43466.56533434665;43491.34762978558;43545;8402.579871006456;8685.522296273703;9668.178204852597;9853.802923941517;9871.40771553709;8659.177378149066;11866.347350895698;12159.696007599792;12177;12298.016158707327;12083.879161208364;12166.878331216707;12175.33035683037;12176.452059657337;12194.207376520499;8670.696525621574;12128.818067728991;12190.57332993341;12207.572734954234;12221.511139554406;8659.437136586102;11577.47901344433;11953;11961.581344652895;12108.939455302756;41013.794931025455;41475.96310092242;41491.377629335584;41529.1694166115;41568.792156039024;3357.5970883494138;3484.7212223022098;3728.291624591319;3731.0299322176156;4115.506139263278;29926;31765.047048588578;32010;32092.839535802406;32121.357572848647;3200.471922132845;3309.12308238317;3378;3378.3918894598964;3386.762926595139;478242;480240;480257.9999999965;480530;481552;62332.376676233565;62751.6862415685;62786.686066569375;62797.05804412937;62962.68518657378;65363;65516;65695;65758;65822;13576.321183940763;16210.027398356136;16370.918145409196;16464.176791160393;16473.752893706605;11459.427028648533;11700.2979821211;12544.623661290176;12608;12618.684532886751;16825.915870420813;16982.915085424494;17008.064556449513;17019.744703829452;18824.435266942015;5656.43435656431;7876.684932602631;7878.842423151505;7922.247386498389;7933.206679332136;714.3320994869813;887.6138879587271;956.4309236004566;957.3203025851724;1082.3451811653993;28014.43971120566;29568.96508622188;29625.111246662636;29972;29987.850060749555;926.6061923682408;951.9480973524156;1018.3126389686931;1062.6280801719336;1063.6330465989222;11927.701807454883;12858.678533036562;15253.618659533378;15441.227938603024;15742.92128539373;625605;676107;681903;923400;932685;47217.527824721314;55817;55879.720601397545;56819.715901420226;59256.407435925954;1359.1165742267408;1363.7681594129022;1377.5316392426623;1379.5999160243416;1380.3443364401828;23648.881755591112;30026.756219450686;30625.846870765505;31041;31485.212869678442;49503.25745113754;50187.49812501828;50194.749026254634;50233;50296.742581435756;588763;591927;592068;592634;593328;25295.36761580975;25439.61840572356;25643.871780640977;25766;25850.35374115662;36902;45794;46336.841578959444;46348.7682561585;46718.53281467278;33192.66807331896;38608.03479913025;38789.6121038786;39633.60366396299;40016;27888.86055569709;36178.27643447064;37838.43242351422;38271.80864095662;39430.60569394269;37285.440718389786;37997;38084.80957595194;38381.80809096048;38485.807570961966;31274.374512509166;33658.975544517976;33884.49173262453;34190.82904585461;34274;24106.87946560256;24133.034678612657;25222.551928783032;25314.114006009702;25617 07:57:43 INFO - PROCESS | 1947 | |2;jquery.html;349.43915016398665;365.4262807392394;367.43048275173476;376.29632587062196;397.0292634508626;14767.335469903854;14880.851191488095;15908.204589770508;20353.694694579557;20873.895630521827;19277.03614819257;19987.700184497244;20521.871297078655;20765.480862978435;20815.791842081573;5216.217567364888;5791.420857914196;6099.451049405553;6113.480354169901;6117.602355846878;4158.563350848162;4384.473863136428;5934.525237980951;6032.939670603281;6081.878362432749;4378.408914796493;5629.240052592889;6295.464885484739;6700.698468568902;6705.396514313711;6457.741690332357;6600.141981542417;6626.072349870998;6769.3907548320885;6771.4582833373215;5793.697786313887;5842.094475356326;5847.678377689225;5850.180974663551;5855.795047173328;26691.599626005627;27179.45641087187;27254.45491090167;27333.726662733516;27654.170374888585;2201.3395981205576;2281.988590057039;2320.7215134184007;2341.1922886604093;2421.8183636227354;15194.620134496616;16046;16220.270087846075;16352.509424717278;16382.83617163825;1673.8744594155364;1867.421099459172;1869.4391682495198;1915.7126431035317;2092.497800527862;135004.32497837447;135631;140251;141780;146980;16028.519144425452;20392.388228353175;20436.978151092684;20885.477863053544;20948.276724025778;26746;34828.30343393118;34857.90852548855;34910;35098;9797.510124493889;9913.959034301439;10722.839157412645;10873.293235939638;11079.667609971713;8642.505990760592;8990.865137022949;9016.250043736723;9173;9223.123803238681;9420.105090016437;9476.763080922894;9655.179309758749;9782.021797820304;9785.363951343283;3017.366353065837;3178.761592880543;3638.9636103639154;3734.3963075632146;3764.4541541476333;722.8084557592242;930.6835675870236;952.5237381309346;969.4522594734094;981.4945303168873;19362.612747744966;20224.797752022587;20320.390388288375;20480.283190088274;20794.376168714964;958.3052287091803;971.8473581018079;979.1872745621117;1016.1515134862325;1028.681108856257;8271.669133234604;8398.370122240856;10429.478526073666;10884.020438160604;10951.397673128055;597993;598075;608928;623031;623453;113535;123864.38067809603;125316;126011.73988260183;130272;946.2240962410757;956.8995255498212;971.8930917599058;973.5618971462728;980.3088822380205;14964.481772623254;17270.791044626756;18214.90892545529;18506.44480665582;18776.248950041845;40711.592884071964;43603.9099022527;52910.20634690406;53514.46485535095;55669.44330556643;74776.49362195234;76532.61733691295;76820.61589692016;78107.60946195232;78288;7031.613261270679;7091;7357.117145942521;7383;7750.92249077502;9104;10835.67492975212;11910;13278.336083195609;13392.58489085277;10976.396298203676;11311.717207069889;11514;11706.70733231676;11716.414179291172;11049.723756906142;11324.263922844988;11617.883821162019;11769.764604707687;11849.289042657469;11473.770524589629;11485.253458525169;11770.411479425824;11849.229800062969;11938.64184074479;8056.033276006682;8202.38482113832;8216.137305583066;8337.95831020841;8453.450525715809;8341.374396920133;10694.983976522219;10784.946075269887;10965.56137754481;11464.770704586028 07:57:43 INFO - PROCESS | 1947 | |3;mootools.html;1512.3043400035983;1576.6137296362392;1743.8779285450016;1860.7439978014836;1899.297260013795;8436.578171091443;8923.018467968526;8925.553722313874;8927.464352138877;8931.866022009675;7809.726659566916;8080.797980050502;8419.663213471455;8685.218330350268;8693.913060869389;1984.3054930774185;1987.3441764217846;2335.4394945213153;2369.490559529701;2376.6078597031556;2318.420394901275;2351.294611616508;2385.296337580418;2390;2396.9760302397012;2253.4253765289827;2266.1275408967585;2276.1350686739015;2290.267114523353;2292.885355732215;2231.732192136954;2359.740428552858;2366.6804981327473;2369.5497855407502;2374.169040835711;2326.1160758911506;2327.359976006595;2328.511012687338;2333.2067097187037;2337.1819863047967;8700.912990870074;8764.123587641248;8796.25231855293;8830.514321712304;8835.160659737314;5163.509466600667;5324.041672498949;5325.573954083664;5333.120035194188;5333.839984800462;2997.520396736512;3444.9827750861336;3493;3656.542932133483;3670.5595328560476;1079.6868908016666;1082.279176109981;1083.918706097046;1103.8068338040891;1104.2546281260118;9585.952070239673;11365.772684546262;11479.827802582968;11500.712482187928;11504.942475287653;4452.354408610733;4515;4678;4708.929366059512;4724.574788269072;9760.219182465386;9762.36544624597;9764.951175244078;9765.072318129767;9767.51162441875;5180.766865491062;5187.688738675692;5192.9740351298005;5193.37679478465;5198.506141916512;4279.593438623326;4378.912421751547;4415.66882483815;4696.084263568571;4712.269598212282;3806.71449641278;3827.196288779332;3924.843006279774;3938.2517321709356;3952.7628342299554;1253.260576260011;1265.73419581887;1275.1647670775658;1276.8595454499998;1283.165942137618;785.4109417936547;841.5834162089805;911.289194428347;932.3007744191856;947.6683160893632;5871.6183448075735;5883.676397798076;6033;6155.138280640714;6316.810495685137;898.8247291778172;945.9547200343659;946.7396465971775;957.305953183936;1002.5839276700087;3825.9617403826164;3986.6810655148097;4059.837606495707;4077.1641813428178;4119.176164767058;10282.845757313646;10759.946200269105;10761.354318740901;10761.730956725987;10776.137908967265;8641.913580864111;10206.744831379276;10596.682099537025;10703.983121603434;10750.516226769814;7983.441159118806;8199.344052475788;8201.343892488587;8201.753947381469;8206.958965205136;5875.3243377012195;5884.146798714248;5967.6121052131475;6087.239095113111;6148.251384955081;9586.089321514444;9830.655927042806;9907.45508997012;10017.098461138532;10089.445080520642;9894.406335619886;10190.592376305161;10208.336458130198;10309.020643038899;10340.793184136124;6880.931190688229;6900.965495172492;7334.119905611361;7489.438292128003;7632.923670763444;8142.226488483821;8452.915470845213;8457.957710211409;8460.492370457792;8476.194761497894;7335.669894854637;7429.59137247435;7429.888551671621;7518;7583.9620801895635;7208.56748595065;7325.597092159983;7387.335139837441;7402.296781805935;7492.925070749223;6845.0759147514445;6978.616176110363;6983.825404364931;6988.336108069725;6989.440844732308;4923.483034281349;4966.428860681068;5062.291279220838;5089.9745501272255;5101.285819985131;4892.828750993698;4957.547381714096;5072.087024335655;5195.76619052136;5206.088934436534 07:57:43 INFO - PROCESS | 1947 | |4;prototype.html;284.83764254375006;292.73653711659506;302.21725730358384;310.4195155060038;314.1314266054359;5228.189630607252;5298.788048478061;5302.886393857295;5306.7081310528;5308.522232999029;4509.346144809001;5145;5219;5221.921671174935;5242.6330156889035;3735.9539328987926;3735.991282353763;3900.7074469414765;3921.901952451183;3944.4674968879262;3687.004508782627;3839.0978120141745;3894.267051162234;3922.548906875703;3995.361901620336;3306.6693330666862;3312.4865645824816;3761.736678432511;3944.664703500206;3973.2450834341525;3754.8122593870335;3823.4264860270905;3895.974093471379;3905.1799122184375;4004.5194576650842;2651.721569235222;3004.7980807676886;3408.9488657670154;3420.538227339302;3451.171718787473;4102.261592913274;4977.92533112;5003.924941125886;5010.674306170087;5015.623828212899;3707.443883417482;3906.980465097685;3947.1118998225456;4208.347706105558;4451;4403.911921761547;4921;5142.820001299974;5375.381831089436;5414.16080507518;3177.602799650044;3332.4668053111627;3765.303418867491;3791.75353602015;3800.0619683961104;5149.99575082859;5305.4164041955355;5465.9180112298345;5705.372409035002;5714.971305165069;3292.2921571862166;3804.565078349858;3810.733248672622;3812.694984401241;3842.884713458601;3289.322445552785;3828.904277393032;3857.267119247334;3864.8454061837774;3867.45855580219;3903.375459926455;4485.416895803524;4493.326001099796;4507.977460112678;4516.23224051912;4605.4933957264675;4975.850724478271;5408.513233808976;5451.509364157245;5580.1629755537;1267.4296566544908;1305.6670549009941;1308.8756568126014;1310.711643438442;1312.468450277639;731.25777336004;761.5506850957961;789.8459800338994;812.427238796647;813.7712054797298;4813.133635945494;5134.666246693953;5145.765016396038;5153.711572106973;5238.659487133325;4845.200541910615;5444.292242008592;5514.80698175562;5604.355499117572;5684.6020778545935;4413.492448368479;4683.437987441529;5051.696898186047;5078;5092.363454568179;2273.5680220758004;2691.0581296546443;2926.3854590536225;2936.3686807336526;2948.6756456789735;5283.169701966121;5771;5839.474447299764;5862.3585396089165;5889.55705852069;4969.503049695001;5461.563074953994;5530.695811730313;5650.880919655129;5766.711664416763;4780.808767649394;5273.598528948806;5654.264945557134;5669.829905102853;5714.685692286881;4539.001419687664;5341.759620816995;5498.542886135097;5572.972135139298;5684.317881854038;4674.6260299176665;4844.975775121102;5247.559884653501;5501.752421140978;5505.752241149078;4335.566443355639;5345.797195630952;5795.420457954171;5808.854778630399;5830.679312637845;3412.505186747858;3539.823008849599;3688.5758137813423;3719.516462859811;3720.2187540616774;4181.895452613709;4861.95138048615;5308.416074231909;5640.23856779346;5660.632058916157;5075.898482030412;5479.75341109659;5479.780808767605;5494.36814766291;5532.861678458071;4797.896483808674;5087.669301495391;5316.441773613715;5392.433794451526;5418.539424148991;4353.325234588644;5262.736863156903;5285.564383150829;5317.388500322358;5367.946320536901;5123.462036486264;5317.893642127213;5325.908188821205;5334.653247538898;5337.919931200958;4730.101280756645;4924.8768780780765;5104.591632669451;5317.813876514459;5354.357477102617 07:57:43 INFO - PROCESS | 1947 | |5;yui.html;674.1775034457962;690.9136357955256;784.6233807772265;785.3285440947988;801.8676918308483;15284.082955022692;15936.999999999985;15947.601309967227;15992.04047757134;16365.754513682305;13990.860091399083;14459.277036148203;14569.12585244886;14810.185439800807;14839;835.2065537739157;851.4848516647432;856.6059612578222;857.536930057768;858.433433933604;675.9966200168992;696.9303069693016;830.754927296446;849.8257857139303;855.7603870916154;909.8635204719312;911.5168960450972;912.4616476278994;913.0686699566438;914.8490499067645;906.0441234497603;907.0611916666252;907.4328544659588;908.9045650206765;909.2135302962955;520.035334454585;535.582245848239;539.1777539252632;666.3170250493234;666.9966650166766;10621;10687.14502839771;14643.70712585753;15172.772408413883;15229.086254824746;14353.856461435356;14744;14938.402463901431;15152.696946061016;15176.165310907896;11858.703532411673;11947.103967202494;11963.64109076729;12051.397430128547;12177;3233.4988076848126;3759.2857357102334;3808.980955095207;3842.9807850960847;3939.625735555118;97159.28407159228;122961;125297.49405011849;128012.71987280101;128205;11132.888671113185;11460.312381257152;11542.422878856023;11560;11576.710582235342;23988.760112399003;24014;24026.279211623678;24049.278521644377;24066.7593324068;7676.232376762391;7760.9223907761325;7780.727674531364;7921.920780792234;8109.797255068553;4256.34026725858;4290.82836686529;4306.504751953503;4323.589259020388;4373.234683930299;3626.1841085755495;3745.101175717808;3765.6987441005203;3766.7363284569815;3770.2836461072857;530.6497711510384;667.7395815631908;675.4731309578536;678.6606696651675;682.5563383800569;525.5401523666792;557.4119304134177;621.0373920423416;626.8276224038335;683.7982795075465;8004.879926801103;8255.9680039995;9426.670066547638;9514.20641734717;9770.071843174886;625.3402660193449;654.1528720307214;662.5627086123136;666.3973144587276;667.2260178193272;3799.7080992462697;3987;4476.865694029184;4589.33454649074;4739.620830333565;126277;165608.17195913944;165799;168242.15878920528;169220;123472.76527234612;135826.64173358338;136620;138559;141556;111981;113331.86668133213;113978.99999999834;114782;118355;7008.579485230903;8761.167689069529;8810.955945220232;8835.24900383449;9103.863442048241;57304.28087157392;58343.416565833795;59299.70350148394;60353;64238.67880660567;66536;73736.63131684522;89154.10845891718;95421.5228923851;96822.0317796813;11928.105392095455;11982.58060967862;12017.939910300393;12364.632214409767;12553.623391298275;12753.681157971125;12792.104552681223;13096;13164.145208237245;13538.59384218475;10789.514471848943;11124.61063862761;11989.460474278852;12137.393130343624;12275.26348419062;11969;12057.479162309894;12200.267983920992;12207.328596926898;12603.93698031504;11885;11905.107116966436;12067.094967877269;12522.49910003626;12527.373631318216;10177.592896284363;10208.846867297145;10286.537105830106;10286.691399258034;10499.422531760827;10298;10505.579776808841;10509.579616815241;10520.78958420812;10522.31604945676 07:57:43 INFO - PROCESS | 1947 | __end_tp_report 07:57:43 INFO - PROCESS | 1947 | __start_cc_report 07:57:43 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,2417 07:57:43 INFO - PROCESS | 1947 | __end_cc_report 07:57:43 INFO - PROCESS | 1947 | __startTimestamp1475852263288__endTimestamp 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | ------- Summary: start ------- 07:57:43 INFO - PROCESS | 1947 | Number of tests: 6 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5749.80 Median:5918.50 stddev:636.26 (10.8%) stddev-sans-first:609.09 07:57:43 INFO - PROCESS | 1947 | Values: 3323.9 3337.5 3351.5 3378.4 3406.6 5583.6 5692.2 5722.1 5839.4 5909.5 5702.8 5724.1 5770.5 5816.4 5843.4 5131.6 5161.3 5189.6 5221.6 5248.8 4831.9 5346.0 5369.7 5381.0 5429.5 5302.7 5336.9 5354.8 5374.9 5413.5 5134.9 5160.8 5220.8 5221.6 5263.1 5170.9 5194.1 5196.9 5243.4 5286.5 5756.9 5764.1 5773.5 5801.0 5842.3 6095.4 6108.5 6121.9 6223.7 6252.5 5575.9 5990.1 6186.7 6196.4 6238.6 5896.7 5902.9 5909.1 5916.5 5918.5 6187.8 6240.7 6299.3 6362.3 6364.5 6124.1 6124.6 6140.1 6189.3 6201.2 6234.9 6244.3 6257.0 6268.8 6282.5 5994.8 6101.9 6195.7 6202.8 6212.8 6095.3 6172.6 6182.4 6183.0 6186.3 4911.8 4942.3 4954.8 4965.0 5008.8 4414.8 4523.1 4540.8 4544.0 4586.9 5770.0 5813.1 5830.2 5839.6 5851.7 6140.2 6241.9 6248.4 6265.2 6274.5 5712.0 5782.8 5793.3 5795.4 5803.4 5380.7 5411.6 5421.6 5430.5 5431.4 6313.5 6344.1 6347.0 6374.3 6444.7 6242.9 6257.7 6263.8 6275.9 6284.9 6441.7 6441.8 6448.8 6450.4 6458.6 6070.8 6097.8 6104.0 6111.7 6181.6 5409.3 6207.4 6234.3 6237.5 6251.1 6144.4 6166.6 6172.7 6187.1 6189.2 5215.7 6016.0 6154.4 6162.4 6170.9 4875.7 5750.0 5835.6 5906.0 5920.6 6078.7 6103.3 6105.5 6122.9 6144.2 5009.3 6000.3 6051.1 6071.1 6129.8 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:74027.92 Median:37917.72 stddev:169027.20 (445.8%) stddev-sans-first:169411.09 07:57:43 INFO - PROCESS | 1947 | Values: 450.8 469.6 517.7 533.5 553.7 40500.8 42119.0 42251.0 44253.9 44299.8 42996.9 43450.3 43466.6 43491.3 43545.0 8402.6 8685.5 9668.2 9853.8 9871.4 8659.2 11866.3 12159.7 12177.0 12298.0 12083.9 12166.9 12175.3 12176.5 12194.2 8670.7 12128.8 12190.6 12207.6 12221.5 8659.4 11577.5 11953.0 11961.6 12108.9 41013.8 41476.0 41491.4 41529.2 41568.8 3357.6 3484.7 3728.3 3731.0 4115.5 29926.0 31765.0 32010.0 32092.8 32121.4 3200.5 3309.1 3378.0 3378.4 3386.8 478242.0 480240.0 480258.0 480530.0 481552.0 62332.4 62751.7 62786.7 62797.1 62962.7 65363.0 65516.0 65695.0 65758.0 65822.0 13576.3 16210.0 16370.9 16464.2 16473.8 11459.4 11700.3 12544.6 12608.0 12618.7 16825.9 16982.9 17008.1 17019.7 18824.4 5656.4 7876.7 7878.8 7922.2 7933.2 714.3 887.6 956.4 957.3 1082.3 28014.4 29569.0 29625.1 29972.0 29987.9 926.6 951.9 1018.3 1062.6 1063.6 11927.7 12858.7 15253.6 15441.2 15742.9 625605.0 676107.0 681903.0 923400.0 932685.0 47217.5 55817.0 55879.7 56819.7 59256.4 1359.1 1363.8 1377.5 1379.6 1380.3 23648.9 30026.8 30625.8 31041.0 31485.2 49503.3 50187.5 50194.7 50233.0 50296.7 588763.0 591927.0 592068.0 592634.0 593328.0 25295.4 25439.6 25643.9 25766.0 25850.4 36902.0 45794.0 46336.8 46348.8 46718.5 33192.7 38608.0 38789.6 39633.6 40016.0 27888.9 36178.3 37838.4 38271.8 39430.6 37285.4 37997.0 38084.8 38381.8 38485.8 31274.4 33659.0 33884.5 34190.8 34274.0 24106.9 24133.0 25222.6 25314.1 25617.0 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:36770.17 Median:17603.67 stddev:102012.93 (579.5%) stddev-sans-first:102262.45 07:57:43 INFO - PROCESS | 1947 | Values: 349.4 365.4 367.4 376.3 397.0 14767.3 14880.9 15908.2 20353.7 20873.9 19277.0 19987.7 20521.9 20765.5 20815.8 5216.2 5791.4 6099.5 6113.5 6117.6 4158.6 4384.5 5934.5 6032.9 6081.9 4378.4 5629.2 6295.5 6700.7 6705.4 6457.7 6600.1 6626.1 6769.4 6771.5 5793.7 5842.1 5847.7 5850.2 5855.8 26691.6 27179.5 27254.5 27333.7 27654.2 2201.3 2282.0 2320.7 2341.2 2421.8 15194.6 16046.0 16220.3 16352.5 16382.8 1673.9 1867.4 1869.4 1915.7 2092.5 135004.3 135631.0 140251.0 141780.0 146980.0 16028.5 20392.4 20437.0 20885.5 20948.3 26746.0 34828.3 34857.9 34910.0 35098.0 9797.5 9914.0 10722.8 10873.3 11079.7 8642.5 8990.9 9016.3 9173.0 9223.1 9420.1 9476.8 9655.2 9782.0 9785.4 3017.4 3178.8 3639.0 3734.4 3764.5 722.8 930.7 952.5 969.5 981.5 19362.6 20224.8 20320.4 20480.3 20794.4 958.3 971.8 979.2 1016.2 1028.7 8271.7 8398.4 10429.5 10884.0 10951.4 597993.0 598075.0 608928.0 623031.0 623453.0 113535.0 123864.4 125316.0 126011.7 130272.0 946.2 956.9 971.9 973.6 980.3 14964.5 17270.8 18214.9 18506.4 18776.2 40711.6 43603.9 52910.2 53514.5 55669.4 74776.5 76532.6 76820.6 78107.6 78288.0 7031.6 7091.0 7357.1 7383.0 7750.9 9104.0 10835.7 11910.0 13278.3 13392.6 10976.4 11311.7 11514.0 11706.7 11716.4 11049.7 11324.3 11617.9 11769.8 11849.3 11473.8 11485.3 11770.4 11849.2 11938.6 8056.0 8202.4 8216.1 8338.0 8453.5 8341.4 10695.0 10784.9 10965.6 11464.8 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5662.33 Median:5081.03 stddev:3147.10 (61.9%) stddev-sans-first:3140.48 07:57:43 INFO - PROCESS | 1947 | Values: 1512.3 1576.6 1743.9 1860.7 1899.3 8436.6 8923.0 8925.6 8927.5 8931.9 7809.7 8080.8 8419.7 8685.2 8693.9 1984.3 1987.3 2335.4 2369.5 2376.6 2318.4 2351.3 2385.3 2390.0 2397.0 2253.4 2266.1 2276.1 2290.3 2292.9 2231.7 2359.7 2366.7 2369.5 2374.2 2326.1 2327.4 2328.5 2333.2 2337.2 8700.9 8764.1 8796.3 8830.5 8835.2 5163.5 5324.0 5325.6 5333.1 5333.8 2997.5 3445.0 3493.0 3656.5 3670.6 1079.7 1082.3 1083.9 1103.8 1104.3 9586.0 11365.8 11479.8 11500.7 11504.9 4452.4 4515.0 4678.0 4708.9 4724.6 9760.2 9762.4 9765.0 9765.1 9767.5 5180.8 5187.7 5193.0 5193.4 5198.5 4279.6 4378.9 4415.7 4696.1 4712.3 3806.7 3827.2 3924.8 3938.3 3952.8 1253.3 1265.7 1275.2 1276.9 1283.2 785.4 841.6 911.3 932.3 947.7 5871.6 5883.7 6033.0 6155.1 6316.8 898.8 946.0 946.7 957.3 1002.6 3826.0 3986.7 4059.8 4077.2 4119.2 10282.8 10759.9 10761.4 10761.7 10776.1 8641.9 10206.7 10596.7 10704.0 10750.5 7983.4 8199.3 8201.3 8201.8 8207.0 5875.3 5884.1 5967.6 6087.2 6148.3 9586.1 9830.7 9907.5 10017.1 10089.4 9894.4 10190.6 10208.3 10309.0 10340.8 6880.9 6901.0 7334.1 7489.4 7632.9 8142.2 8452.9 8458.0 8460.5 8476.2 7335.7 7429.6 7429.9 7518.0 7584.0 7208.6 7325.6 7387.3 7402.3 7492.9 6845.1 6978.6 6983.8 6988.3 6989.4 4923.5 4966.4 5062.3 5090.0 5101.3 4892.8 4957.5 5072.1 5195.8 5206.1 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4352.68 Median:4972.68 stddev:1356.52 (27.3%) stddev-sans-first:1325.52 07:57:43 INFO - PROCESS | 1947 | Values: 284.8 292.7 302.2 310.4 314.1 5228.2 5298.8 5302.9 5306.7 5308.5 4509.3 5145.0 5219.0 5221.9 5242.6 3736.0 3736.0 3900.7 3921.9 3944.5 3687.0 3839.1 3894.3 3922.5 3995.4 3306.7 3312.5 3761.7 3944.7 3973.2 3754.8 3823.4 3896.0 3905.2 4004.5 2651.7 3004.8 3408.9 3420.5 3451.2 4102.3 4977.9 5003.9 5010.7 5015.6 3707.4 3907.0 3947.1 4208.3 4451.0 4403.9 4921.0 5142.8 5375.4 5414.2 3177.6 3332.5 3765.3 3791.8 3800.1 5150.0 5305.4 5465.9 5705.4 5715.0 3292.3 3804.6 3810.7 3812.7 3842.9 3289.3 3828.9 3857.3 3864.8 3867.5 3903.4 4485.4 4493.3 4508.0 4516.2 4605.5 4975.9 5408.5 5451.5 5580.2 1267.4 1305.7 1308.9 1310.7 1312.5 731.3 761.6 789.8 812.4 813.8 4813.1 5134.7 5145.8 5153.7 5238.7 4845.2 5444.3 5514.8 5604.4 5684.6 4413.5 4683.4 5051.7 5078.0 5092.4 2273.6 2691.1 2926.4 2936.4 2948.7 5283.2 5771.0 5839.5 5862.4 5889.6 4969.5 5461.6 5530.7 5650.9 5766.7 4780.8 5273.6 5654.3 5669.8 5714.7 4539.0 5341.8 5498.5 5573.0 5684.3 4674.6 4845.0 5247.6 5501.8 5505.8 4335.6 5345.8 5795.4 5808.9 5830.7 3412.5 3539.8 3688.6 3719.5 3720.2 4181.9 4862.0 5308.4 5640.2 5660.6 5075.9 5479.8 5479.8 5494.4 5532.9 4797.9 5087.7 5316.4 5392.4 5418.5 4353.3 5262.7 5285.6 5317.4 5367.9 5123.5 5317.9 5325.9 5334.7 5337.9 4730.1 4924.9 5104.6 5317.8 5354.4 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:25264.74 Median:3685.64 stddev:41768.08 (1133.3%) stddev-sans-first:41844.44 07:57:43 INFO - PROCESS | 1947 | Values: 674.2 690.9 784.6 785.3 801.9 15284.1 15937.0 15947.6 15992.0 16365.8 13990.9 14459.3 14569.1 14810.2 14839.0 835.2 851.5 856.6 857.5 858.4 676.0 696.9 830.8 849.8 855.8 909.9 911.5 912.5 913.1 914.8 906.0 907.1 907.4 908.9 909.2 520.0 535.6 539.2 666.3 667.0 10621.0 10687.1 14643.7 15172.8 15229.1 14353.9 14744.0 14938.4 15152.7 15176.2 11858.7 11947.1 11963.6 12051.4 12177.0 3233.5 3759.3 3809.0 3843.0 3939.6 97159.3 122961.0 125297.5 128012.7 128205.0 11132.9 11460.3 11542.4 11560.0 11576.7 23988.8 24014.0 24026.3 24049.3 24066.8 7676.2 7760.9 7780.7 7921.9 8109.8 4256.3 4290.8 4306.5 4323.6 4373.2 3626.2 3745.1 3765.7 3766.7 3770.3 530.6 667.7 675.5 678.7 682.6 525.5 557.4 621.0 626.8 683.8 8004.9 8256.0 9426.7 9514.2 9770.1 625.3 654.2 662.6 666.4 667.2 3799.7 3987.0 4476.9 4589.3 4739.6 126277.0 165608.2 165799.0 168242.2 169220.0 123472.8 135826.6 136620.0 138559.0 141556.0 111981.0 113331.9 113979.0 114782.0 118355.0 7008.6 8761.2 8811.0 8835.2 9103.9 57304.3 58343.4 59299.7 60353.0 64238.7 66536.0 73736.6 89154.1 95421.5 96822.0 11928.1 11982.6 12017.9 12364.6 12553.6 12753.7 12792.1 13096.0 13164.1 13538.6 10789.5 11124.6 11989.5 12137.4 12275.3 11969.0 12057.5 12200.3 12207.3 12603.9 11885.0 11905.1 12067.1 12522.5 12527.4 10177.6 10208.8 10286.5 10286.7 10499.4 10298.0 10505.6 10509.6 10520.8 10522.3 07:57:43 INFO - PROCESS | 1947 | -------- Summary: end -------- 07:57:43 INFO - PROCESS | 1947 | 07:57:43 INFO - TEST-INFO | 1947: exit 0 07:57:43 INFO - TEST-OK | dromaeo_css | took 1120203ms 07:57:43 INFO - TEST-START | kraken 07:57:43 INFO - operating with platform_type : mac_ 07:57:43 INFO - Initialising browser for kraken test... 07:57:43 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp86NRbg/profile http://localhost:50903/getInfo.html) 07:57:46 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 07:57:46 INFO - PROCESS | 1950 | colorDepth:24 07:57:46 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 07:57:46 INFO - PROCESS | 1950 | __metrics 07:57:46 INFO - PROCESS | 1950 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:46 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:47 INFO - TEST-INFO | 1950: exit 0 07:57:47 INFO - Browser initialized. 07:57:47 INFO - Running cycle 1/1 for kraken test... 07:57:47 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp86NRbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:59 INFO - PROCESS | 1951 | RSS: Main: 234512384 07:57:59 INFO - PROCESS | 1951 | 07:58:02 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:03 INFO - PROCESS | 1951 | RSS: Main: 293703680 07:58:03 INFO - PROCESS | 1951 | 07:58:05 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-dft) 07:58:06 INFO - PROCESS | 1951 | RSS: Main: 292507648 07:58:06 INFO - PROCESS | 1951 | 07:58:09 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-fft) 07:58:10 INFO - PROCESS | 1951 | RSS: Main: 385441792 07:58:10 INFO - PROCESS | 1951 | 07:58:12 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-oscillator) 07:58:13 INFO - PROCESS | 1951 | RSS: Main: 287821824 07:58:13 INFO - PROCESS | 1951 | 07:58:15 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:15 INFO - PROCESS | 1951 | RSS: Main: 288948224 07:58:15 INFO - PROCESS | 1951 | 07:58:18 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:19 INFO - PROCESS | 1951 | RSS: Main: 326762496 07:58:19 INFO - PROCESS | 1951 | 07:58:22 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:22 INFO - PROCESS | 1951 | RSS: Main: 327884800 07:58:22 INFO - PROCESS | 1951 | 07:58:25 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50903/tests/kraken/driver.html?testName=json-parse-financial) 07:58:26 INFO - PROCESS | 1951 | RSS: Main: 324911104 07:58:26 INFO - PROCESS | 1951 | 07:58:27 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:28 INFO - PROCESS | 1951 | RSS: Main: 301744128 07:58:28 INFO - PROCESS | 1951 | 07:58:30 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:31 INFO - PROCESS | 1951 | RSS: Main: 302886912 07:58:31 INFO - PROCESS | 1951 | 07:58:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:33 INFO - PROCESS | 1951 | RSS: Main: 305541120 07:58:33 INFO - PROCESS | 1951 | 07:58:36 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:37 INFO - PROCESS | 1951 | RSS: Main: 318242816 07:58:37 INFO - PROCESS | 1951 | 07:58:40 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:41 INFO - PROCESS | 1951 | RSS: Main: 317816832 07:58:41 INFO - PROCESS | 1951 | 07:58:42 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50903/tests/kraken/driver.html?testName=ai-astar) 07:58:43 INFO - PROCESS | 1951 | RSS: Main: 361459712 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | __start_tp_report 07:58:43 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 07:58:43 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 07:58:43 INFO - PROCESS | 1951 | |i|pagename|runs| 07:58:43 INFO - PROCESS | 1951 | |0;ai-astar;153;173;112;113;112;111;113;112;112;112 07:58:43 INFO - PROCESS | 1951 | |1;audio-beat-detection;159;111;115;148;117;113;114;116;163;130 07:58:43 INFO - PROCESS | 1951 | |2;audio-dft;181;185;238;184;184;182;183;180;183;182 07:58:43 INFO - PROCESS | 1951 | |3;audio-fft;80;59;61;104;116;87;59;58;83;58 07:58:43 INFO - PROCESS | 1951 | |4;audio-oscillator;93;104;95;70;67;69;92;68;69;90 07:58:43 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;89;85;89;86;88;84;89;86;88;97 07:58:43 INFO - PROCESS | 1951 | |6;imaging-darkroom;94;111;152;152;94;94;94;95;94;94 07:58:43 INFO - PROCESS | 1951 | |7;imaging-desaturate;133;135;95;84;84;85;84;85;86;82 07:58:43 INFO - PROCESS | 1951 | |8;json-parse-financial;54;54;53;54;54;56;54;54;54;55 07:58:43 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;66;82;65;77;74;71;70;69;67;72 07:58:43 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;87;86;86;87;85;84;87;85;87;88 07:58:43 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;147;146;160;164;157;145;143;144;176;144 07:58:43 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;174;171;172;172;175;175;173;172;171;173 07:58:43 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;61;86;89;69;68;70;73;86;88;90 07:58:43 INFO - PROCESS | 1951 | __end_tp_report 07:58:43 INFO - PROCESS | 1951 | __start_cc_report 07:58:43 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,2006 07:58:43 INFO - PROCESS | 1951 | __end_cc_report 07:58:43 INFO - PROCESS | 1951 | __startTimestamp1475852323244__endTimestamp 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | ------- Summary: start ------- 07:58:43 INFO - PROCESS | 1951 | Number of tests: 14 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:122.30 Median:112.50 stddev:21.97 (19.5%) stddev-sans-first:20.30 07:58:43 INFO - PROCESS | 1951 | Values: 153.0 173.0 112.0 113.0 112.0 111.0 113.0 112.0 112.0 112.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:123.50 stddev:20.36 (16.5%) stddev-sans-first:18.38 07:58:43 INFO - PROCESS | 1951 | Values: 159.0 111.0 115.0 148.0 117.0 113.0 114.0 116.0 163.0 130.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:188.20 Median:183.50 stddev:17.56 (9.6%) stddev-sans-first:18.43 07:58:43 INFO - PROCESS | 1951 | Values: 181.0 185.0 238.0 184.0 184.0 182.0 183.0 180.0 183.0 182.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:76.50 Median:60.00 stddev:21.13 (35.2%) stddev-sans-first:22.37 07:58:43 INFO - PROCESS | 1951 | Values: 80.0 59.0 61.0 104.0 116.0 87.0 59.0 58.0 83.0 58.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:80.00 stddev:14.30 (17.9%) stddev-sans-first:14.57 07:58:43 INFO - PROCESS | 1951 | Values: 93.0 104.0 95.0 70.0 67.0 69.0 92.0 68.0 69.0 90.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:88.50 stddev:3.60 (4.1%) stddev-sans-first:3.81 07:58:43 INFO - PROCESS | 1951 | Values: 89.0 85.0 89.0 86.0 88.0 84.0 89.0 86.0 88.0 97.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:94.00 stddev:24.09 (25.6%) stddev-sans-first:25.06 07:58:43 INFO - PROCESS | 1951 | Values: 94.0 111.0 152.0 152.0 94.0 94.0 94.0 95.0 94.0 94.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:84.50 stddev:20.70 (24.5%) stddev-sans-first:16.87 07:58:43 INFO - PROCESS | 1951 | Values: 133.0 135.0 95.0 84.0 84.0 85.0 84.0 85.0 86.0 82.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 07:58:43 INFO - PROCESS | 1951 | Values: 54.0 54.0 53.0 54.0 54.0 56.0 54.0 54.0 54.0 55.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:5.25 (7.3%) stddev-sans-first:5.21 07:58:43 INFO - PROCESS | 1951 | Values: 66.0 82.0 65.0 77.0 74.0 71.0 70.0 69.0 67.0 72.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 07:58:43 INFO - PROCESS | 1951 | Values: 87.0 86.0 86.0 87.0 85.0 84.0 87.0 85.0 87.0 88.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:152.00 stddev:11.18 (7.4%) stddev-sans-first:11.67 07:58:43 INFO - PROCESS | 1951 | Values: 147.0 146.0 160.0 164.0 157.0 145.0 143.0 144.0 176.0 144.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 07:58:43 INFO - PROCESS | 1951 | Values: 174.0 171.0 172.0 172.0 175.0 175.0 173.0 172.0 171.0 173.0 07:58:43 INFO - PROCESS | 1951 | 07:58:43 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:86.00 stddev:10.81 (12.6%) stddev-sans-first:9.56 07:58:43 INFO - PROCESS | 1951 | Values: 61.0 86.0 89.0 69.0 68.0 70.0 73.0 86.0 88.0 90.0 07:58:43 INFO - PROCESS | 1951 | -------- Summary: end -------- 07:58:43 INFO - PROCESS | 1951 | 07:58:44 INFO - TEST-INFO | 1951: exit 0 07:58:44 INFO - TEST-OK | kraken | took 60195ms 07:58:44 INFO - SUITE-END | took 1180s 07:58:44 INFO - Completed test suite (00:19:40) 07:58:44 INFO - javascript benchmark 07:58:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.933521329573, 3337.516060171275, 3351.48052051932, 3378.3918894598964, 3406.6082400523933, 5583.609147359686, 5692.203091567184, 5722.055860782976, 5839.416058394158, 5909.497692696115, 5702.800401985931, 5724.084146536555, 5770.480656740892, 5816.360200377955, 5843.444872737083, 5131.563817075553, 5161.251618515313, 5189.6107791915565, 5221.634485586011, 5248.8425347239645, 4831.903361932759, 5346.0, 5369.677819330833, 5380.973095134519, 5429.484199001088, 5302.708351040691, 5336.946630533684, 5354.759035843396, 5374.892502149954, 5413.458654134574, 5134.948650513522, 5160.767765450526, 5220.817271395521, 5221.556167725748, 5263.105272103751, 5170.870728231786, 5194.117000109953, 5196.948030519684, 5243.449437809051, 5286.5242128208265, 5756.884862302731, 5764.135379693038, 5773.509251713609, 5801.0428279333855, 5842.298924129132, 6095.420935011167, 6108.493847774667, 6121.940772763084, 6223.688815559204, 6252.531060170505, 5575.8884822303735, 5990.131430942489, 6186.690665466754, 6196.411340922605, 6238.625682459067, 5896.705164741746, 5902.940970590282, 5909.054551271776, 5916.497097746654, 5918.496927761103, 6187.752489900354, 6240.656763878031, 6299.307076221612, 6362.2683391409655, 6364.459020983269, 6124.081387791778, 6124.564025909317, 6140.114146351208, 6189.257289125334, 6201.162843016135, 6234.875302493925, 6244.2819075805955, 6257.0, 6268.843278917972, 6282.528810339243, 5994.790182343597, 6101.938980610137, 6195.690215489208, 6202.782902598477, 6212.81361559154, 6095.3042442883725, 6172.629642221481, 6182.443580077815, 6183.0, 6186.288576813724, 4911.778969946361, 4942.258661200849, 4954.801807927714, 4965.0069986002945, 5008.774605142778, 4414.779261036935, 4523.140603285366, 4540.750258735801, 4543.954560454419, 4586.908261834745, 5769.9711501442225, 5813.069908814569, 5830.183774271605, 5839.591228613956, 5851.707414629337, 6140.17107690456, 6241.906371404432, 6248.4376406123665, 6265.216847894013, 6274.498040156776, 5712.028955077647, 5782.797602083907, 5793.275840519935, 5795.391483894215, 5803.419658034247, 5380.704061276668, 5411.594130440233, 5421.593380496479, 5430.51125398716, 5431.402545719968, 6313.526485513697, 6344.143540621957, 6346.968265158737, 6374.26695929974, 6444.709988050456, 6242.906356404748, 6257.655828929453, 6263.843403914939, 6275.874482510233, 6284.905726414016, 6441.67791610427, 6441.774537891151, 6448.806535803933, 6450.3549645037, 6458.580192287674, 6070.817875463743, 6097.796915383898, 6104.0347610180015, 6111.682900513672, 6181.629102253879, 5409.29679141709, 6207.379262073757, 6234.2830574484515, 6237.5009999200865, 6251.124842521959, 6144.354842741448, 6166.568340216321, 6172.6913654318005, 6187.133801267916, 6189.164462797465, 5215.687058776485, 6015.969920150371, 6154.415330543591, 6162.352952939877, 6170.876582468236, 4875.731834749123, 5750.0, 5835.6498610081835, 5906.0255057914965, 5920.644761314335, 6078.696065196634, 6103.277060575968, 6105.45050945417, 6122.938770612415, 6144.187464698014, 5009.273655320031, 6000.309964354155, 6051.062085376773, 6071.058985857199, 6129.84675383119], "value": 5710.174367513204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.8331917190639, 469.58441779025554, 517.6816258001328, 533.5411546070379, 553.6518577264361, 40500.797496012514, 42119.0, 42251.0, 44253.89365265862, 44299.77850110753, 42996.92507687309, 43450.34824477635, 43466.56533434665, 43491.34762978558, 43545.0, 8402.579871006456, 8685.522296273703, 9668.178204852597, 9853.802923941517, 9871.40771553709, 8659.177378149066, 11866.347350895698, 12159.696007599792, 12177.0, 12298.016158707327, 12083.879161208364, 12166.878331216707, 12175.33035683037, 12176.452059657337, 12194.207376520499, 8670.696525621574, 12128.818067728991, 12190.57332993341, 12207.572734954234, 12221.511139554406, 8659.437136586102, 11577.47901344433, 11953.0, 11961.581344652895, 12108.939455302756, 41013.794931025455, 41475.96310092242, 41491.377629335584, 41529.1694166115, 41568.792156039024, 3357.5970883494138, 3484.7212223022098, 3728.291624591319, 3731.0299322176156, 4115.506139263278, 29926.0, 31765.047048588578, 32010.0, 32092.839535802406, 32121.357572848647, 3200.471922132845, 3309.12308238317, 3378.0, 3378.3918894598964, 3386.762926595139, 478242.0, 480240.0, 480257.9999999965, 480530.0, 481552.0, 62332.376676233565, 62751.6862415685, 62786.686066569375, 62797.05804412937, 62962.68518657378, 65363.0, 65516.0, 65695.0, 65758.0, 65822.0, 13576.321183940763, 16210.027398356136, 16370.918145409196, 16464.176791160393, 16473.752893706605, 11459.427028648533, 11700.2979821211, 12544.623661290176, 12608.0, 12618.684532886751, 16825.915870420813, 16982.915085424494, 17008.064556449513, 17019.744703829452, 18824.435266942015, 5656.43435656431, 7876.684932602631, 7878.842423151505, 7922.247386498389, 7933.206679332136, 714.3320994869813, 887.6138879587271, 956.4309236004566, 957.3203025851724, 1082.3451811653993, 28014.43971120566, 29568.96508622188, 29625.111246662636, 29972.0, 29987.850060749555, 926.6061923682408, 951.9480973524156, 1018.3126389686931, 1062.6280801719336, 1063.6330465989222, 11927.701807454883, 12858.678533036562, 15253.618659533378, 15441.227938603024, 15742.92128539373, 625605.0, 676107.0, 681903.0, 923400.0, 932685.0, 47217.527824721314, 55817.0, 55879.720601397545, 56819.715901420226, 59256.407435925954, 1359.1165742267408, 1363.7681594129022, 1377.5316392426623, 1379.5999160243416, 1380.3443364401828, 23648.881755591112, 30026.756219450686, 30625.846870765505, 31041.0, 31485.212869678442, 49503.25745113754, 50187.49812501828, 50194.749026254634, 50233.0, 50296.742581435756, 588763.0, 591927.0, 592068.0, 592634.0, 593328.0, 25295.36761580975, 25439.61840572356, 25643.871780640977, 25766.0, 25850.35374115662, 36902.0, 45794.0, 46336.841578959444, 46348.7682561585, 46718.53281467278, 33192.66807331896, 38608.03479913025, 38789.6121038786, 39633.60366396299, 40016.0, 27888.86055569709, 36178.27643447064, 37838.43242351422, 38271.80864095662, 39430.60569394269, 37285.440718389786, 37997.0, 38084.80957595194, 38381.80809096048, 38485.807570961966, 31274.374512509166, 33658.975544517976, 33884.49173262453, 34190.82904585461, 34274.0, 24106.87946560256, 24133.034678612657, 25222.551928783032, 25314.114006009702, 25617.0], "value": 20308.41748126837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.43915016398665, 365.4262807392394, 367.43048275173476, 376.29632587062196, 397.0292634508626, 14767.335469903854, 14880.851191488095, 15908.204589770508, 20353.694694579557, 20873.895630521827, 19277.03614819257, 19987.700184497244, 20521.871297078655, 20765.480862978435, 20815.791842081573, 5216.217567364888, 5791.420857914196, 6099.451049405553, 6113.480354169901, 6117.602355846878, 4158.563350848162, 4384.473863136428, 5934.525237980951, 6032.939670603281, 6081.878362432749, 4378.408914796493, 5629.240052592889, 6295.464885484739, 6700.698468568902, 6705.396514313711, 6457.741690332357, 6600.141981542417, 6626.072349870998, 6769.3907548320885, 6771.4582833373215, 5793.697786313887, 5842.094475356326, 5847.678377689225, 5850.180974663551, 5855.795047173328, 26691.599626005627, 27179.45641087187, 27254.45491090167, 27333.726662733516, 27654.170374888585, 2201.3395981205576, 2281.988590057039, 2320.7215134184007, 2341.1922886604093, 2421.8183636227354, 15194.620134496616, 16046.0, 16220.270087846075, 16352.509424717278, 16382.83617163825, 1673.8744594155364, 1867.421099459172, 1869.4391682495198, 1915.7126431035317, 2092.497800527862, 135004.32497837447, 135631.0, 140251.0, 141780.0, 146980.0, 16028.519144425452, 20392.388228353175, 20436.978151092684, 20885.477863053544, 20948.276724025778, 26746.0, 34828.30343393118, 34857.90852548855, 34910.0, 35098.0, 9797.510124493889, 9913.959034301439, 10722.839157412645, 10873.293235939638, 11079.667609971713, 8642.505990760592, 8990.865137022949, 9016.250043736723, 9173.0, 9223.123803238681, 9420.105090016437, 9476.763080922894, 9655.179309758749, 9782.021797820304, 9785.363951343283, 3017.366353065837, 3178.761592880543, 3638.9636103639154, 3734.3963075632146, 3764.4541541476333, 722.8084557592242, 930.6835675870236, 952.5237381309346, 969.4522594734094, 981.4945303168873, 19362.612747744966, 20224.797752022587, 20320.390388288375, 20480.283190088274, 20794.376168714964, 958.3052287091803, 971.8473581018079, 979.1872745621117, 1016.1515134862325, 1028.681108856257, 8271.669133234604, 8398.370122240856, 10429.478526073666, 10884.020438160604, 10951.397673128055, 597993.0, 598075.0, 608928.0, 623031.0, 623453.0, 113535.0, 123864.38067809603, 125316.0, 126011.73988260183, 130272.0, 946.2240962410757, 956.8995255498212, 971.8930917599058, 973.5618971462728, 980.3088822380205, 14964.481772623254, 17270.791044626756, 18214.90892545529, 18506.44480665582, 18776.248950041845, 40711.592884071964, 43603.9099022527, 52910.20634690406, 53514.46485535095, 55669.44330556643, 74776.49362195234, 76532.61733691295, 76820.61589692016, 78107.60946195232, 78288.0, 7031.613261270679, 7091.0, 7357.117145942521, 7383.0, 7750.92249077502, 9104.0, 10835.67492975212, 11910.0, 13278.336083195609, 13392.58489085277, 10976.396298203676, 11311.717207069889, 11514.0, 11706.70733231676, 11716.414179291172, 11049.723756906142, 11324.263922844988, 11617.883821162019, 11769.764604707687, 11849.289042657469, 11473.770524589629, 11485.253458525169, 11770.411479425824, 11849.229800062969, 11938.64184074479, 8056.033276006682, 8202.38482113832, 8216.137305583066, 8337.95831020841, 8453.450525715809, 8341.374396920133, 10694.983976522219, 10784.946075269887, 10965.56137754481, 11464.770704586028], "value": 10466.118328803896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.3043400035983, 1576.6137296362392, 1743.8779285450016, 1860.7439978014836, 1899.297260013795, 8436.578171091443, 8923.018467968526, 8925.553722313874, 8927.464352138877, 8931.866022009675, 7809.726659566916, 8080.797980050502, 8419.663213471455, 8685.218330350268, 8693.913060869389, 1984.3054930774185, 1987.3441764217846, 2335.4394945213153, 2369.490559529701, 2376.6078597031556, 2318.420394901275, 2351.294611616508, 2385.296337580418, 2390.0, 2396.9760302397012, 2253.4253765289827, 2266.1275408967585, 2276.1350686739015, 2290.267114523353, 2292.885355732215, 2231.732192136954, 2359.740428552858, 2366.6804981327473, 2369.5497855407502, 2374.169040835711, 2326.1160758911506, 2327.359976006595, 2328.511012687338, 2333.2067097187037, 2337.1819863047967, 8700.912990870074, 8764.123587641248, 8796.25231855293, 8830.514321712304, 8835.160659737314, 5163.509466600667, 5324.041672498949, 5325.573954083664, 5333.120035194188, 5333.839984800462, 2997.520396736512, 3444.9827750861336, 3493.0, 3656.542932133483, 3670.5595328560476, 1079.6868908016666, 1082.279176109981, 1083.918706097046, 1103.8068338040891, 1104.2546281260118, 9585.952070239673, 11365.772684546262, 11479.827802582968, 11500.712482187928, 11504.942475287653, 4452.354408610733, 4515.0, 4678.0, 4708.929366059512, 4724.574788269072, 9760.219182465386, 9762.36544624597, 9764.951175244078, 9765.072318129767, 9767.51162441875, 5180.766865491062, 5187.688738675692, 5192.9740351298005, 5193.37679478465, 5198.506141916512, 4279.593438623326, 4378.912421751547, 4415.66882483815, 4696.084263568571, 4712.269598212282, 3806.71449641278, 3827.196288779332, 3924.843006279774, 3938.2517321709356, 3952.7628342299554, 1253.260576260011, 1265.73419581887, 1275.1647670775658, 1276.8595454499998, 1283.165942137618, 785.4109417936547, 841.5834162089805, 911.289194428347, 932.3007744191856, 947.6683160893632, 5871.6183448075735, 5883.676397798076, 6033.0, 6155.138280640714, 6316.810495685137, 898.8247291778172, 945.9547200343659, 946.7396465971775, 957.305953183936, 1002.5839276700087, 3825.9617403826164, 3986.6810655148097, 4059.837606495707, 4077.1641813428178, 4119.176164767058, 10282.845757313646, 10759.946200269105, 10761.354318740901, 10761.730956725987, 10776.137908967265, 8641.913580864111, 10206.744831379276, 10596.682099537025, 10703.983121603434, 10750.516226769814, 7983.441159118806, 8199.344052475788, 8201.343892488587, 8201.753947381469, 8206.958965205136, 5875.3243377012195, 5884.146798714248, 5967.6121052131475, 6087.239095113111, 6148.251384955081, 9586.089321514444, 9830.655927042806, 9907.45508997012, 10017.098461138532, 10089.445080520642, 9894.406335619886, 10190.592376305161, 10208.336458130198, 10309.020643038899, 10340.793184136124, 6880.931190688229, 6900.965495172492, 7334.119905611361, 7489.438292128003, 7632.923670763444, 8142.226488483821, 8452.915470845213, 8457.957710211409, 8460.492370457792, 8476.194761497894, 7335.669894854637, 7429.59137247435, 7429.888551671621, 7518.0, 7583.9620801895635, 7208.56748595065, 7325.597092159983, 7387.335139837441, 7402.296781805935, 7492.925070749223, 6845.0759147514445, 6978.616176110363, 6983.825404364931, 6988.336108069725, 6989.440844732308, 4923.483034281349, 4966.428860681068, 5062.291279220838, 5089.9745501272255, 5101.285819985131, 4892.828750993698, 4957.547381714096, 5072.087024335655, 5195.76619052136, 5206.088934436534], "value": 4562.413028663249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.83764254375006, 292.73653711659506, 302.21725730358384, 310.4195155060038, 314.1314266054359, 5228.189630607252, 5298.788048478061, 5302.886393857295, 5306.7081310528, 5308.522232999029, 4509.346144809001, 5145.0, 5219.0, 5221.921671174935, 5242.6330156889035, 3735.9539328987926, 3735.991282353763, 3900.7074469414765, 3921.901952451183, 3944.4674968879262, 3687.004508782627, 3839.0978120141745, 3894.267051162234, 3922.548906875703, 3995.361901620336, 3306.6693330666862, 3312.4865645824816, 3761.736678432511, 3944.664703500206, 3973.2450834341525, 3754.8122593870335, 3823.4264860270905, 3895.974093471379, 3905.1799122184375, 4004.5194576650842, 2651.721569235222, 3004.7980807676886, 3408.9488657670154, 3420.538227339302, 3451.171718787473, 4102.261592913274, 4977.92533112, 5003.924941125886, 5010.674306170087, 5015.623828212899, 3707.443883417482, 3906.980465097685, 3947.1118998225456, 4208.347706105558, 4451.0, 4403.911921761547, 4921.0, 5142.820001299974, 5375.381831089436, 5414.16080507518, 3177.602799650044, 3332.4668053111627, 3765.303418867491, 3791.75353602015, 3800.0619683961104, 5149.99575082859, 5305.4164041955355, 5465.9180112298345, 5705.372409035002, 5714.971305165069, 3292.2921571862166, 3804.565078349858, 3810.733248672622, 3812.694984401241, 3842.884713458601, 3289.322445552785, 3828.904277393032, 3857.267119247334, 3864.8454061837774, 3867.45855580219, 3903.375459926455, 4485.416895803524, 4493.326001099796, 4507.977460112678, 4516.23224051912, 4605.4933957264675, 4975.850724478271, 5408.513233808976, 5451.509364157245, 5580.1629755537, 1267.4296566544908, 1305.6670549009941, 1308.8756568126014, 1310.711643438442, 1312.468450277639, 731.25777336004, 761.5506850957961, 789.8459800338994, 812.427238796647, 813.7712054797298, 4813.133635945494, 5134.666246693953, 5145.765016396038, 5153.711572106973, 5238.659487133325, 4845.200541910615, 5444.292242008592, 5514.80698175562, 5604.355499117572, 5684.6020778545935, 4413.492448368479, 4683.437987441529, 5051.696898186047, 5078.0, 5092.363454568179, 2273.5680220758004, 2691.0581296546443, 2926.3854590536225, 2936.3686807336526, 2948.6756456789735, 5283.169701966121, 5771.0, 5839.474447299764, 5862.3585396089165, 5889.55705852069, 4969.503049695001, 5461.563074953994, 5530.695811730313, 5650.880919655129, 5766.711664416763, 4780.808767649394, 5273.598528948806, 5654.264945557134, 5669.829905102853, 5714.685692286881, 4539.001419687664, 5341.759620816995, 5498.542886135097, 5572.972135139298, 5684.317881854038, 4674.6260299176665, 4844.975775121102, 5247.559884653501, 5501.752421140978, 5505.752241149078, 4335.566443355639, 5345.797195630952, 5795.420457954171, 5808.854778630399, 5830.679312637845, 3412.505186747858, 3539.823008849599, 3688.5758137813423, 3719.516462859811, 3720.2187540616774, 4181.895452613709, 4861.95138048615, 5308.416074231909, 5640.23856779346, 5660.632058916157, 5075.898482030412, 5479.75341109659, 5479.780808767605, 5494.36814766291, 5532.861678458071, 4797.896483808674, 5087.669301495391, 5316.441773613715, 5392.433794451526, 5418.539424148991, 4353.325234588644, 5262.736863156903, 5285.564383150829, 5317.388500322358, 5367.946320536901, 5123.462036486264, 5317.893642127213, 5325.908188821205, 5334.653247538898, 5337.919931200958, 4730.101280756645, 4924.8768780780765, 5104.591632669451, 5317.813876514459, 5354.357477102617], "value": 3919.70818778627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.1775034457962, 690.9136357955256, 784.6233807772265, 785.3285440947988, 801.8676918308483, 15284.082955022692, 15936.999999999985, 15947.601309967227, 15992.04047757134, 16365.754513682305, 13990.860091399083, 14459.277036148203, 14569.12585244886, 14810.185439800807, 14839.0, 835.2065537739157, 851.4848516647432, 856.6059612578222, 857.536930057768, 858.433433933604, 675.9966200168992, 696.9303069693016, 830.754927296446, 849.8257857139303, 855.7603870916154, 909.8635204719312, 911.5168960450972, 912.4616476278994, 913.0686699566438, 914.8490499067645, 906.0441234497603, 907.0611916666252, 907.4328544659588, 908.9045650206765, 909.2135302962955, 520.035334454585, 535.582245848239, 539.1777539252632, 666.3170250493234, 666.9966650166766, 10621.0, 10687.14502839771, 14643.70712585753, 15172.772408413883, 15229.086254824746, 14353.856461435356, 14744.0, 14938.402463901431, 15152.696946061016, 15176.165310907896, 11858.703532411673, 11947.103967202494, 11963.64109076729, 12051.397430128547, 12177.0, 3233.4988076848126, 3759.2857357102334, 3808.980955095207, 3842.9807850960847, 3939.625735555118, 97159.28407159228, 122961.0, 125297.49405011849, 128012.71987280101, 128205.0, 11132.888671113185, 11460.312381257152, 11542.422878856023, 11560.0, 11576.710582235342, 23988.760112399003, 24014.0, 24026.279211623678, 24049.278521644377, 24066.7593324068, 7676.232376762391, 7760.9223907761325, 7780.727674531364, 7921.920780792234, 8109.797255068553, 4256.34026725858, 4290.82836686529, 4306.504751953503, 4323.589259020388, 4373.234683930299, 3626.1841085755495, 3745.101175717808, 3765.6987441005203, 3766.7363284569815, 3770.2836461072857, 530.6497711510384, 667.7395815631908, 675.4731309578536, 678.6606696651675, 682.5563383800569, 525.5401523666792, 557.4119304134177, 621.0373920423416, 626.8276224038335, 683.7982795075465, 8004.879926801103, 8255.9680039995, 9426.670066547638, 9514.20641734717, 9770.071843174886, 625.3402660193449, 654.1528720307214, 662.5627086123136, 666.3973144587276, 667.2260178193272, 3799.7080992462697, 3987.0, 4476.865694029184, 4589.33454649074, 4739.620830333565, 126277.0, 165608.17195913944, 165799.0, 168242.15878920528, 169220.0, 123472.76527234612, 135826.64173358338, 136620.0, 138559.0, 141556.0, 111981.0, 113331.86668133213, 113978.99999999834, 114782.0, 118355.0, 7008.579485230903, 8761.167689069529, 8810.955945220232, 8835.24900383449, 9103.863442048241, 57304.28087157392, 58343.416565833795, 59299.70350148394, 60353.0, 64238.67880660567, 66536.0, 73736.63131684522, 89154.10845891718, 95421.5228923851, 96822.0317796813, 11928.105392095455, 11982.58060967862, 12017.939910300393, 12364.632214409767, 12553.623391298275, 12753.681157971125, 12792.104552681223, 13096.0, 13164.145208237245, 13538.59384218475, 10789.514471848943, 11124.61063862761, 11989.460474278852, 12137.393130343624, 12275.26348419062, 11969.0, 12057.479162309894, 12200.267983920992, 12207.328596926898, 12603.93698031504, 11885.0, 11905.107116966436, 12067.094967877269, 12522.49910003626, 12527.373631318216, 10177.592896284363, 10208.846867297145, 10286.537105830106, 10286.691399258034, 10499.422531760827, 10298.0, 10505.579776808841, 10509.579616815241, 10520.78958420812, 10522.31604945676], "value": 7649.96967430045, "unit": "score"}], "name": "dromaeo_css", "value": 7413.868723669769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 173.0, 112.0, 113.0, 112.0, 111.0, 113.0, 112.0, 112.0, 112.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 111.0, 115.0, 148.0, 117.0, 113.0, 114.0, 116.0, 163.0, 130.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 238.0, 184.0, 184.0, 182.0, 183.0, 180.0, 183.0, 182.0], "value": 188.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 104.0, 116.0, 87.0, 59.0, 58.0, 83.0, 58.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 104.0, 95.0, 70.0, 67.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 84.0, 89.0, 86.0, 88.0, 97.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 111.0, 152.0, 152.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 95.0, 84.0, 84.0, 85.0, 84.0, 85.0, 86.0, 82.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 65.0, 77.0, 74.0, 71.0, 70.0, 69.0, 67.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 85.0, 84.0, 87.0, 85.0, 87.0, 88.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 160.0, 164.0, 157.0, 145.0, 143.0, 144.0, 176.0, 144.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 172.0, 172.0, 175.0, 175.0, 173.0, 172.0, 171.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 86.0, 89.0, 69.0, 68.0, 70.0, 73.0, 86.0, 88.0, 90.0], "value": 78.0, "unit": "score"}], "name": "kraken", "value": 1503.1999999999998, "alertThreshold": 2.0}]} 07:58:44 INFO - Return code: 0 07:58:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:44 INFO - # TBPL SUCCESS # 07:58:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:44 INFO - 2016-10-07 07:58:44.528 screenresolution[1955:17352] starting screenresolution argv=screenresolution get 07:58:44 INFO - 2016-10-07 07:58:44.531 screenresolution[1955:17352] Display 0: 1600x1200x32@60 07:58:44 INFO - 2016-10-07 07:58:44.537 screenresolution[1956:17355] starting screenresolution argv=screenresolution list 07:58:44 INFO - Available Modes on Display 0 07:58:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:44 INFO - Intel Iris: 07:58:44 INFO - Chipset Model: Intel Iris 07:58:44 INFO - Type: GPU 07:58:44 INFO - Bus: Built-In 07:58:44 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:44 INFO - Vendor: Intel (0x8086) 07:58:44 INFO - Device ID: 0x0a2e 07:58:44 INFO - Revision ID: 0x0009 07:58:44 INFO - Displays: 07:58:44 INFO - Display: 07:58:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:44 INFO - Display Serial Number: 1600x1200 60 07:58:44 INFO - Main Display: Yes 07:58:44 INFO - Mirror: Off 07:58:44 INFO - Online: Yes 07:58:44 INFO - Rotation: Supported 07:58:44 INFO - Return code: 0 07:58:44 INFO - Running post-action listener: _resource_record_post_action 07:58:44 INFO - [mozharness: 2016-10-07 14:58:44.772317Z] Finished run-tests step (success) 07:58:44 INFO - Running post-run listener: _resource_record_post_run 07:58:44 INFO - Total resource usage - Wall time: 1216s; CPU: 53.0%; Read bytes: 851968; Write bytes: 705364480; Read time: 8; Write time: 1912 07:58:44 INFO - TinderboxPrint: CPU usage
53.3% 07:58:44 INFO - TinderboxPrint: I/O read bytes / time
851,968 / 8 07:58:44 INFO - TinderboxPrint: I/O write bytes / time
705,364,480 / 1,912 07:58:44 INFO - TinderboxPrint: CPU idle
2,271.1 (46.7%) 07:58:44 INFO - TinderboxPrint: CPU system
971.8 (20.0%) 07:58:44 INFO - TinderboxPrint: CPU user
1,622.7 (33.4%) 07:58:44 INFO - TinderboxPrint: Swap in / out
408,449,024 / 0 07:58:44 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 402209280; Write bytes: 396175360; Read time: 31368; Write time: 665 07:58:44 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 815104; Write bytes: 294169088; Read time: 8; Write time: 1208 07:58:45 INFO - Running post-run listener: _upload_blobber_files 07:58:45 INFO - Blob upload gear active. 07:58:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:45 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 07:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:46 INFO - (blobuploader) - INFO - Done attempting. 07:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:48 INFO - (blobuploader) - INFO - Done attempting. 07:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:50 INFO - (blobuploader) - INFO - Done attempting. 07:58:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:50 INFO - Return code: 0 07:58:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fef32e5ab0721687925dee31b4181e149356145d6eeeb0e113c2f5f058c4687e1ee6acf51fd7efbc7855803a5141b644b4f65b9cec5b3ec71e56a844199d7b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffea7f2bd03e58c8fa649061d8764d0308fb4d41733fd2f082d73252bf9999c650382698df34da30a800c2f118b962127e9748b147184676883e59286d2da1a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b055d81428ebac83f0518ac6f7cc5983ea7e00ecc0cab51922b75846e2a870a451db4bceba1942a47f8a599413f427b4f173187d20152cfe68ff23ff561679cf"} 07:58:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:50 INFO - Contents: 07:58:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fef32e5ab0721687925dee31b4181e149356145d6eeeb0e113c2f5f058c4687e1ee6acf51fd7efbc7855803a5141b644b4f65b9cec5b3ec71e56a844199d7b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffea7f2bd03e58c8fa649061d8764d0308fb4d41733fd2f082d73252bf9999c650382698df34da30a800c2f118b962127e9748b147184676883e59286d2da1a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b055d81428ebac83f0518ac6f7cc5983ea7e00ecc0cab51922b75846e2a870a451db4bceba1942a47f8a599413f427b4f173187d20152cfe68ff23ff561679cf"} 07:58:50 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:50 INFO - Copying logs to upload dir... 07:58:50 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.350579 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-07 07:58:50.590142) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 07:58:50.593296) ========= 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.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fef32e5ab0721687925dee31b4181e149356145d6eeeb0e113c2f5f058c4687e1ee6acf51fd7efbc7855803a5141b644b4f65b9cec5b3ec71e56a844199d7b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffea7f2bd03e58c8fa649061d8764d0308fb4d41733fd2f082d73252bf9999c650382698df34da30a800c2f118b962127e9748b147184676883e59286d2da1a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b055d81428ebac83f0518ac6f7cc5983ea7e00ecc0cab51922b75846e2a870a451db4bceba1942a47f8a599413f427b4f173187d20152cfe68ff23ff561679cf"} build_url:https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/F6xc2pDFQJu8t08XMmKumg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fef32e5ab0721687925dee31b4181e149356145d6eeeb0e113c2f5f058c4687e1ee6acf51fd7efbc7855803a5141b644b4f65b9cec5b3ec71e56a844199d7b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffea7f2bd03e58c8fa649061d8764d0308fb4d41733fd2f082d73252bf9999c650382698df34da30a800c2f118b962127e9748b147184676883e59286d2da1a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b055d81428ebac83f0518ac6f7cc5983ea7e00ecc0cab51922b75846e2a870a451db4bceba1942a47f8a599413f427b4f173187d20152cfe68ff23ff561679cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 07:58:50.626335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:58:50.626739) ========= 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.FwBB48QeXx/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.hWx7zGDagv/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005184 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 07:58:50.675969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 07:58:50.676315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 07:58:50.676667) ========= ========= Total master_lag: 0.17 =========