builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0335 starttime: 1476278053.57 results: success (0) buildid: 20161012030211 builduid: a769541e4bb74131a09b21df7c55a423 revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.571437) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.572026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.572378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.597790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.598263) ========= 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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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-12 06:14:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-10-12 06:14:13 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.752388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.752785) ========= 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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.027419 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:13.802163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-12 06:14:13.802668) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 500baee3ce9f1b701ace9d38489cbc112d076c72 --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 500baee3ce9f1b701ace9d38489cbc112d076c72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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-12 06:14:13,885 truncating revision to first 12 chars 2016-10-12 06:14:13,885 Setting DEBUG logging. 2016-10-12 06:14:13,885 attempt 1/10 2016-10-12 06:14:13,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/500baee3ce9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 06:14:14,965 unpacking tar archive at: mozilla-central-500baee3ce9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339442 ========= master_lag: 3.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-10-12 06:14:18.688510) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:18.688822) ========= script_repo_revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:18.689215) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:18.689489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 06:14:19.131868) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-12 06:14:19.132278) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:14:19 INFO - MultiFileLogger online at 20161012 06:14:19 in /builds/slave/test 06:14:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:14:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:19 INFO - {'append_to_log': False, 06:14:19 INFO - 'base_work_dir': '/builds/slave/test', 06:14:19 INFO - 'blob_upload_branch': 'Firefox', 06:14:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:19 INFO - 'branch': 'Firefox', 06:14:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:19 INFO - 'config_files': ('talos/mac_config.py',), 06:14:19 INFO - 'default_actions': ('clobber', 06:14:19 INFO - 'read-buildbot-config', 06:14:19 INFO - 'download-and-extract', 06:14:19 INFO - 'populate-webroot', 06:14:19 INFO - 'create-virtualenv', 06:14:19 INFO - 'install', 06:14:19 INFO - 'run-tests'), 06:14:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:19 INFO - 'download_minidump_stackwalk': True, 06:14:19 INFO - 'download_symbols': 'ondemand', 06:14:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:19 INFO - 'installer_path': 'installer.exe', 06:14:19 INFO - 'log_level': 'info', 06:14:19 INFO - 'log_name': 'talos', 06:14:19 INFO - 'log_to_console': True, 06:14:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:14:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:14:19 INFO - 'opt_config_files': (), 06:14:19 INFO - 'pip_index': False, 06:14:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:19 INFO - 'cmd': ('bash', 06:14:19 INFO - '-c', 06:14:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:19 INFO - 'enabled': True, 06:14:19 INFO - 'halt_on_failure': False, 06:14:19 INFO - 'name': 'check_screen_resolution'},), 06:14:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:19 INFO - 'cmd': ('bash', 06:14:19 INFO - '-c', 06:14:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:19 INFO - 'enabled': True, 06:14:19 INFO - 'halt_on_failure': False, 06:14:19 INFO - 'name': 'check_screen_resolution'},), 06:14:19 INFO - 'run_cmd_checks_enabled': True, 06:14:19 INFO - 'sps_profile': False, 06:14:19 INFO - 'sps_profile_interval': 0, 06:14:19 INFO - 'suite': 'dromaeojs-e10s', 06:14:19 INFO - 'system_bits': '32', 06:14:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:19 INFO - 'title': 't-yosemite-r7-0335', 06:14:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:19 INFO - 'use_talos_json': True, 06:14:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:19 INFO - 'work_dir': 'build'} 06:14:19 INFO - [mozharness: 2016-10-12 13:14:19.333365Z] Running clobber step. 06:14:19 INFO - Running pre-action listener: _resource_record_pre_action 06:14:19 INFO - Running main action method: clobber 06:14:19 INFO - rmtree: /builds/slave/test/build 06:14:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:21 INFO - Running post-action listener: _resource_record_post_action 06:14:21 INFO - [mozharness: 2016-10-12 13:14:21.515754Z] Finished clobber step (success) 06:14:21 INFO - [mozharness: 2016-10-12 13:14:21.515878Z] Running read-buildbot-config step. 06:14:21 INFO - Running pre-action listener: _resource_record_pre_action 06:14:21 INFO - Running main action method: read_buildbot_config 06:14:21 INFO - Using buildbot properties: 06:14:21 INFO - { 06:14:21 INFO - "project": "", 06:14:21 INFO - "product": "firefox", 06:14:21 INFO - "script_repo_revision": "production", 06:14:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:14:21 INFO - "repository": "", 06:14:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:14:21 INFO - "buildid": "20161012030211", 06:14:21 INFO - "stage_platform": "macosx64", 06:14:21 INFO - "basedir": "/builds/slave/test", 06:14:21 INFO - "nightly_build": "True", 06:14:21 INFO - "buildnumber": 10, 06:14:21 INFO - "slavename": "t-yosemite-r7-0335", 06:14:21 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:14:21 INFO - "platform": "yosemite_r7", 06:14:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:14:21 INFO - "branch": "mozilla-central", 06:14:21 INFO - "repo_path": "mozilla-central", 06:14:21 INFO - "revision": "500baee3ce9f1b701ace9d38489cbc112d076c72", 06:14:21 INFO - "pgo_build": "False", 06:14:21 INFO - "builduid": "a769541e4bb74131a09b21df7c55a423", 06:14:21 INFO - "slavebuilddir": "test" 06:14:21 INFO - } 06:14:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:14:21 INFO - Running post-action listener: _resource_record_post_action 06:14:21 INFO - [mozharness: 2016-10-12 13:14:21.519471Z] Finished read-buildbot-config step (success) 06:14:21 INFO - [mozharness: 2016-10-12 13:14:21.519582Z] Running download-and-extract step. 06:14:21 INFO - Running pre-action listener: _resource_record_pre_action 06:14:21 INFO - Running main action method: download_and_extract 06:14:21 INFO - mkdir: /builds/slave/test/build/tests 06:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:21 INFO - trying https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:14:21 INFO - Downloading https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/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 06:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/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 06:14:22 INFO - Downloaded 1199 bytes. 06:14:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:14:22 INFO - Using the following test package requirements: 06:14:22 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:14:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:14:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:14:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'jsshell-mac.zip'], 06:14:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:14:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:14:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:14:22 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:14:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:14:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:14:22 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:14:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:14:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:14:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:14:22 INFO - Fetch https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:14:23 INFO - Http code: 200 06:14:23 INFO - via: 1.1 6e65abb04cb818a6ec78111935b507f7.cloudfront.net (CloudFront) 06:14:23 INFO - x-amz-cf-id: oYnAKuoU5120zi3ZrRNr7i4_bwXSo2XywFVDB-DHnvI8vyetbbwg6w== 06:14:23 INFO - x-amz-version-id: l2U8Iwi_b6RiWqlnGJ8d1R_yWDwOrkBl 06:14:23 INFO - Expected file size: 16508680 06:14:23 INFO - Obtained file size: 16508680 06:14:30 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 06:14:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:14:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:14:30 INFO - Fetch https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:14:31 INFO - Http code: 200 06:14:31 INFO - via: 1.1 dc553909528b8b63475c922dc07d8ba6.cloudfront.net (CloudFront) 06:14:31 INFO - x-amz-cf-id: C9rKVGDxPbgCsqXO7uebIikryAbe3oQrXohLKf0zslfUddCJj2W4vA== 06:14:31 INFO - x-amz-version-id: l2U8Iwi_b6RiWqlnGJ8d1R_yWDwOrkBl 06:14:31 INFO - Expected file size: 16508680 06:14:31 INFO - Obtained file size: 16508680 06:14:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:14:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:14:37 INFO - Fetch https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:14:38 INFO - Http code: 200 06:14:38 INFO - via: 1.1 515297ac55a7ae01bf8c7d03df4fecb1.cloudfront.net (CloudFront) 06:14:38 INFO - x-amz-cf-id: i9N6p9TKyHoRyYyodzTKkU9TW7wS5bJJOzpl0tTwb19aTe0sVd3-eQ== 06:14:38 INFO - x-amz-version-id: VxHcHZvJtfF5OFBE7Vd8IVqj6aUsC13O 06:14:38 INFO - Expected file size: 14409006 06:14:38 INFO - Obtained file size: 14409006 06:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:38 INFO - trying https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/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 06:14:41 INFO - Downloaded 111819546 bytes. 06:14:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:14:41 INFO - mkdir: /builds/slave/test/properties 06:14:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:41 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:41 INFO - Contents: 06:14:41 INFO - build_url:https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:14:42 INFO - Running post-action listener: _resource_record_post_action 06:14:42 INFO - Running post-action listener: set_extra_try_arguments 06:14:42 INFO - [mozharness: 2016-10-12 13:14:42.420379Z] Finished download-and-extract step (success) 06:14:42 INFO - [mozharness: 2016-10-12 13:14:42.420528Z] Running populate-webroot step. 06:14:42 INFO - Running pre-action listener: _resource_record_pre_action 06:14:42 INFO - Running main action method: populate_webroot 06:14:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:42 INFO - '--tppagecycles', 06:14:42 INFO - '7'], 06:14:42 INFO - 'tests': ['tsvgm']}}, 06:14:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['damp', 'tps']}, 06:14:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'tests': ['damp', 'tps']}, 06:14:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['dromaeo_dom']}, 06:14:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['basic_compositor_video']}, 06:14:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['a11yr', 06:14:42 INFO - 'ts_paint', 06:14:42 INFO - 'tpaint', 06:14:42 INFO - 'sessionrestore', 06:14:42 INFO - 'sessionrestore_no_auto_restore', 06:14:42 INFO - 'tabpaint']}, 06:14:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['tsvgx', 06:14:42 INFO - 'tsvgr_opacity', 06:14:42 INFO - 'tart', 06:14:42 INFO - 'tscrollx', 06:14:42 INFO - 'cart']}, 06:14:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:42 INFO - 'tsvgr_opacity', 06:14:42 INFO - 'tart', 06:14:42 INFO - 'tscrollx', 06:14:42 INFO - 'cart']}, 06:14:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'talos_options': ['--disable-e10s'], 06:14:42 INFO - 'tests': ['tp5o']}, 06:14:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'tests': ['tp5o']}, 06:14:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'talos_options': ['--disable-e10s', 06:14:42 INFO - '--xperf_path', 06:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:42 INFO - 'tests': ['tp5n']}, 06:14:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:42 INFO - 'talos_options': ['--xperf_path', 06:14:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:42 INFO - 'tests': ['tp5n']}}, 06:14:42 INFO - 'talos.zip': {'path': '', 06:14:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:42 INFO - Running post-action listener: _resource_record_post_action 06:14:42 INFO - [mozharness: 2016-10-12 13:14:42.439868Z] Finished populate-webroot step (success) 06:14:42 INFO - [mozharness: 2016-10-12 13:14:42.439957Z] Running create-virtualenv step. 06:14:42 INFO - Running pre-action listener: _resource_record_pre_action 06:14:42 INFO - Running main action method: create_virtualenv 06:14:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:14:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:42 INFO - Using real prefix '/tools/python27' 06:14:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:46 INFO - Installing pip.................done. 06:14:46 INFO - Return code: 0 06:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:14:46 INFO - Reading from file tmpfile_stdout 06:14:46 INFO - Output received: 06:14:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:14:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:46 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:46 INFO - 'HOME': '/Users/cltbld', 06:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:46 INFO - 'LOGNAME': 'cltbld', 06:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:46 INFO - 'MOZ_NO_REMOTE': '1', 06:14:46 INFO - 'NO_EM_RESTART': '1', 06:14:46 INFO - 'PAGER': '/bin/cat', 06:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:46 INFO - 'PWD': '/builds/slave/test', 06:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:46 INFO - 'SHELL': '/bin/bash', 06:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:46 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:46 INFO - 'USER': 'cltbld', 06:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:46 INFO - 'XPC_FLAGS': '0x0', 06:14:46 INFO - 'XPC_SERVICE_NAME': '0', 06:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:14:46 INFO - Cleaning up... 06:14:46 INFO - Return code: 0 06:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:46 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:46 INFO - 'HOME': '/Users/cltbld', 06:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:46 INFO - 'LOGNAME': 'cltbld', 06:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:46 INFO - 'MOZ_NO_REMOTE': '1', 06:14:46 INFO - 'NO_EM_RESTART': '1', 06:14:46 INFO - 'PAGER': '/bin/cat', 06:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:46 INFO - 'PWD': '/builds/slave/test', 06:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:46 INFO - 'SHELL': '/bin/bash', 06:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:46 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:46 INFO - 'USER': 'cltbld', 06:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:46 INFO - 'XPC_FLAGS': '0x0', 06:14:46 INFO - 'XPC_SERVICE_NAME': '0', 06:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:47 INFO - Downloading/unpacking psutil>=3.1.1 06:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:50 INFO - Installing collected packages: psutil 06:14:50 INFO - Running setup.py install for psutil 06:14:50 INFO - building 'psutil._psutil_osx' extension 06:14:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:14:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:14:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:14:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:14:51 INFO - building 'psutil._psutil_posix' extension 06:14:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:14:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:14:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:14:51 INFO - ^ 06:14:51 INFO - 1 warning generated. 06:14:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:51 INFO - Successfully installed psutil 06:14:51 INFO - Cleaning up... 06:14:51 INFO - Return code: 0 06:14:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:51 INFO - 'HOME': '/Users/cltbld', 06:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:51 INFO - 'LOGNAME': 'cltbld', 06:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:51 INFO - 'MOZ_NO_REMOTE': '1', 06:14:51 INFO - 'NO_EM_RESTART': '1', 06:14:51 INFO - 'PAGER': '/bin/cat', 06:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:51 INFO - 'PWD': '/builds/slave/test', 06:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:51 INFO - 'SHELL': '/bin/bash', 06:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:51 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:51 INFO - 'USER': 'cltbld', 06:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:51 INFO - 'XPC_FLAGS': '0x0', 06:14:51 INFO - 'XPC_SERVICE_NAME': '0', 06:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:54 INFO - Installing collected packages: mozsystemmonitor 06:14:54 INFO - Running setup.py install for mozsystemmonitor 06:14:54 INFO - Successfully installed mozsystemmonitor 06:14:54 INFO - Cleaning up... 06:14:54 INFO - Return code: 0 06:14:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:54 INFO - 'HOME': '/Users/cltbld', 06:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:54 INFO - 'LOGNAME': 'cltbld', 06:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:54 INFO - 'MOZ_NO_REMOTE': '1', 06:14:54 INFO - 'NO_EM_RESTART': '1', 06:14:54 INFO - 'PAGER': '/bin/cat', 06:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:54 INFO - 'PWD': '/builds/slave/test', 06:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:54 INFO - 'SHELL': '/bin/bash', 06:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:54 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:54 INFO - 'USER': 'cltbld', 06:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:54 INFO - 'XPC_FLAGS': '0x0', 06:14:54 INFO - 'XPC_SERVICE_NAME': '0', 06:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:54 INFO - Downloading/unpacking jsonschema==2.5.1 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:57 INFO - warning: no files found matching '*.txt' 06:14:57 INFO - no previously-included directories found matching 'build' 06:14:57 INFO - no previously-included directories found matching 'dist' 06:14:57 INFO - no previously-included directories found matching '.git*' 06:14:57 INFO - Installing collected packages: jsonschema, functools32 06:14:58 INFO - Running setup.py install for functools32 06:14:58 INFO - warning: no files found matching '*.txt' 06:14:58 INFO - no previously-included directories found matching 'build' 06:14:58 INFO - no previously-included directories found matching 'dist' 06:14:58 INFO - no previously-included directories found matching '.git*' 06:14:58 INFO - Successfully installed jsonschema functools32 06:14:58 INFO - Cleaning up... 06:14:58 INFO - Return code: 0 06:14:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:58 INFO - 'HOME': '/Users/cltbld', 06:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:58 INFO - 'LOGNAME': 'cltbld', 06:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:58 INFO - 'MOZ_NO_REMOTE': '1', 06:14:58 INFO - 'NO_EM_RESTART': '1', 06:14:58 INFO - 'PAGER': '/bin/cat', 06:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:58 INFO - 'PWD': '/builds/slave/test', 06:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:58 INFO - 'SHELL': '/bin/bash', 06:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:58 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:58 INFO - 'USER': 'cltbld', 06:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:58 INFO - 'XPC_FLAGS': '0x0', 06:14:58 INFO - 'XPC_SERVICE_NAME': '0', 06:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:14:58 INFO - Cleaning up... 06:14:58 INFO - Return code: 0 06:14:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:58 INFO - 'HOME': '/Users/cltbld', 06:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:58 INFO - 'LOGNAME': 'cltbld', 06:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:58 INFO - 'MOZ_NO_REMOTE': '1', 06:14:58 INFO - 'NO_EM_RESTART': '1', 06:14:58 INFO - 'PAGER': '/bin/cat', 06:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:58 INFO - 'PWD': '/builds/slave/test', 06:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:58 INFO - 'SHELL': '/bin/bash', 06:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:14:58 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:58 INFO - 'USER': 'cltbld', 06:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:58 INFO - 'XPC_FLAGS': '0x0', 06:14:58 INFO - 'XPC_SERVICE_NAME': '0', 06:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:02 INFO - Downloading docopt-0.6.1.tar.gz 06:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:02 INFO - Running setup.py install for blobuploader 06:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:02 INFO - Running setup.py install for requests 06:15:03 INFO - Running setup.py install for docopt 06:15:03 INFO - Successfully installed blobuploader requests docopt 06:15:03 INFO - Cleaning up... 06:15:03 INFO - Return code: 0 06:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:03 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:03 INFO - 'HOME': '/Users/cltbld', 06:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:03 INFO - 'LOGNAME': 'cltbld', 06:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:03 INFO - 'MOZ_NO_REMOTE': '1', 06:15:03 INFO - 'NO_EM_RESTART': '1', 06:15:03 INFO - 'PAGER': '/bin/cat', 06:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:03 INFO - 'PWD': '/builds/slave/test', 06:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:03 INFO - 'SHELL': '/bin/bash', 06:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:15:03 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:03 INFO - 'USER': 'cltbld', 06:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:03 INFO - 'XPC_FLAGS': '0x0', 06:15:03 INFO - 'XPC_SERVICE_NAME': '0', 06:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:03 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-DoS4ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:03 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-xGe81p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:03 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-qaCyTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-nWPvYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-QNKASd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-kfZA9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-EDqqcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-YQbZyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-63E_4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-uvNP0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-eGTKs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:04 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-1_hxA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:05 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-D9JdOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:05 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-4KFgQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:05 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-lqLebi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:05 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-bRlTMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:05 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-uWCm5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:05 INFO - Running setup.py install for manifestparser 06:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:05 INFO - Running setup.py install for mozcrash 06:15:05 INFO - Running setup.py install for mozdebug 06:15:05 INFO - Running setup.py install for mozdevice 06:15:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Running setup.py install for mozfile 06:15:06 INFO - Running setup.py install for mozhttpd 06:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Running setup.py install for mozinfo 06:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Running setup.py install for mozInstall 06:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:06 INFO - Running setup.py install for mozleak 06:15:06 INFO - Running setup.py install for mozlog 06:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Running setup.py install for moznetwork 06:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Running setup.py install for mozprocess 06:15:07 INFO - Running setup.py install for mozprofile 06:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Running setup.py install for mozrunner 06:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:07 INFO - Running setup.py install for mozscreenshot 06:15:07 INFO - Running setup.py install for moztest 06:15:07 INFO - Running setup.py install for mozversion 06:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:08 INFO - Cleaning up... 06:15:08 INFO - Return code: 0 06:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:08 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:08 INFO - 'HOME': '/Users/cltbld', 06:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:08 INFO - 'LOGNAME': 'cltbld', 06:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:08 INFO - 'MOZ_NO_REMOTE': '1', 06:15:08 INFO - 'NO_EM_RESTART': '1', 06:15:08 INFO - 'PAGER': '/bin/cat', 06:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:08 INFO - 'PWD': '/builds/slave/test', 06:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:08 INFO - 'SHELL': '/bin/bash', 06:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:15:08 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:08 INFO - 'USER': 'cltbld', 06:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:08 INFO - 'XPC_FLAGS': '0x0', 06:15:08 INFO - 'XPC_SERVICE_NAME': '0', 06:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-numyQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-RNKWrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:08 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)) 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-mOGBqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-bU09gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-8LcT0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:08 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-TY6Cmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-FRmsZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-AillFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-lIDbE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-8lImrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-jvejEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-7T49Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-MOLlwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-xsMs_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:09 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)) 06:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:09 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-VTjDMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:10 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-dtWl8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:10 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Wk2OhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:15:10 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)) 06:15:10 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)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:13 INFO - Downloading blessings-1.6.tar.gz 06:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:13 INFO - Installing collected packages: blessings 06:15:13 INFO - Running setup.py install for blessings 06:15:13 INFO - Successfully installed blessings 06:15:13 INFO - Cleaning up... 06:15:13 INFO - Return code: 0 06:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:13 INFO - Reading from file tmpfile_stdout 06:15:13 INFO - Current package versions: 06:15:13 INFO - blessings == 1.6 06:15:13 INFO - blobuploader == 1.2.4 06:15:13 INFO - docopt == 0.6.1 06:15:13 INFO - functools32 == 3.2.3-2 06:15:13 INFO - jsonschema == 2.5.1 06:15:13 INFO - manifestparser == 1.1 06:15:13 INFO - mozInstall == 1.12 06:15:13 INFO - mozcrash == 0.17 06:15:13 INFO - mozdebug == 0.1 06:15:13 INFO - mozdevice == 0.48 06:15:13 INFO - mozfile == 1.2 06:15:13 INFO - mozhttpd == 0.7 06:15:13 INFO - mozinfo == 0.9 06:15:13 INFO - mozleak == 0.1 06:15:13 INFO - mozlog == 3.4 06:15:13 INFO - moznetwork == 0.27 06:15:13 INFO - mozprocess == 0.23 06:15:13 INFO - mozprofile == 0.28 06:15:13 INFO - mozrunner == 6.12 06:15:13 INFO - mozscreenshot == 0.1 06:15:13 INFO - mozsystemmonitor == 0.3 06:15:13 INFO - moztest == 0.7 06:15:13 INFO - mozversion == 1.4 06:15:13 INFO - psutil == 3.1.1 06:15:13 INFO - requests == 1.2.3 06:15:13 INFO - wsgiref == 0.1.2 06:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:14 INFO - 'HOME': '/Users/cltbld', 06:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:14 INFO - 'LOGNAME': 'cltbld', 06:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:14 INFO - 'MOZ_NO_REMOTE': '1', 06:15:14 INFO - 'NO_EM_RESTART': '1', 06:15:14 INFO - 'PAGER': '/bin/cat', 06:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:14 INFO - 'PWD': '/builds/slave/test', 06:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:14 INFO - 'SHELL': '/bin/bash', 06:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:15:14 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:14 INFO - 'USER': 'cltbld', 06:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:14 INFO - 'XPC_FLAGS': '0x0', 06:15:14 INFO - 'XPC_SERVICE_NAME': '0', 06:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:14 INFO - Cleaning up... 06:15:14 INFO - Return code: 0 06:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 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 0x10540d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105383570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf5348c420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, '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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:14 INFO - 'HOME': '/Users/cltbld', 06:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:14 INFO - 'LOGNAME': 'cltbld', 06:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:14 INFO - 'MOZ_NO_REMOTE': '1', 06:15:14 INFO - 'NO_EM_RESTART': '1', 06:15:14 INFO - 'PAGER': '/bin/cat', 06:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:14 INFO - 'PWD': '/builds/slave/test', 06:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:14 INFO - 'SHELL': '/bin/bash', 06:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:15:14 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:14 INFO - 'USER': 'cltbld', 06:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:14 INFO - 'XPC_FLAGS': '0x0', 06:15:14 INFO - 'XPC_SERVICE_NAME': '0', 06:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:14 INFO - Cleaning up... 06:15:14 INFO - Return code: 0 06:15:14 INFO - Running post-action listener: _resource_record_post_action 06:15:14 INFO - Running post-action listener: _start_resource_monitoring 06:15:14 INFO - Starting resource monitoring. 06:15:14 INFO - [mozharness: 2016-10-12 13:15:14.705945Z] Finished create-virtualenv step (success) 06:15:14 INFO - [mozharness: 2016-10-12 13:15:14.707014Z] Running install step. 06:15:14 INFO - Running pre-action listener: _resource_record_pre_action 06:15:14 INFO - Running main action method: install 06:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:14 INFO - Reading from file tmpfile_stdout 06:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:15 INFO - Reading from file tmpfile_stdout 06:15:15 INFO - Output received: 06:15:15 INFO - Usage: mozinstall [options] installer 06:15:15 INFO - Options: 06:15:15 INFO - -h, --help show this help message and exit 06:15:15 INFO - -d DEST, --destination=DEST 06:15:15 INFO - Directory to install application into. [default: 06:15:15 INFO - "/builds/slave/test"] 06:15:15 INFO - --app=APP Application being installed. [default: firefox] 06:15:15 INFO - mkdir: /builds/slave/test/build/application 06:15:15 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'] 06:15:15 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 06:15:48 INFO - Reading from file tmpfile_stdout 06:15:48 INFO - Output received: 06:15:48 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:15:48 INFO - Running post-action listener: _resource_record_post_action 06:15:48 INFO - [mozharness: 2016-10-12 13:15:48.972828Z] Finished install step (success) 06:15:48 INFO - [mozharness: 2016-10-12 13:15:48.972996Z] Running run-tests step. 06:15:48 INFO - Running pre-action listener: _resource_record_pre_action 06:15:48 INFO - Running main action method: run_tests 06:15:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:48 INFO - 2016-10-12 06:15:48.987 screenresolution[1643:7441] starting screenresolution argv=screenresolution get 06:15:48 INFO - 2016-10-12 06:15:48.989 screenresolution[1643:7441] Display 0: 1600x1200x32@60 06:15:48 INFO - 2016-10-12 06:15:48.995 screenresolution[1644:7443] starting screenresolution argv=screenresolution list 06:15:48 INFO - Available Modes on Display 0 06:15:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:49 INFO - Intel Iris: 06:15:49 INFO - Chipset Model: Intel Iris 06:15:49 INFO - Type: GPU 06:15:49 INFO - Bus: Built-In 06:15:49 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:49 INFO - Vendor: Intel (0x8086) 06:15:49 INFO - Device ID: 0x0a2e 06:15:49 INFO - Revision ID: 0x0009 06:15:49 INFO - Displays: 06:15:49 INFO - Display: 06:15:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:49 INFO - Display Serial Number: 1600x1200 60 06:15:49 INFO - Main Display: Yes 06:15:49 INFO - Mirror: Off 06:15:49 INFO - Online: Yes 06:15:49 INFO - Rotation: Supported 06:15:49 INFO - Return code: 0 06:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:49 INFO - Python 2.7.3 06:15:49 INFO - Return code: 0 06:15:49 INFO - grabbing minidump binary from tooltool 06:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:49 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 0x105221d30>, '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 0x105047db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105219b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:15:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:15:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:15:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:49 INFO - Return code: 0 06:15:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:15:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:15:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0335 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OvpoyIVEZE/Render', 06:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:49 INFO - 'HOME': '/Users/cltbld', 06:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:49 INFO - 'LOGNAME': 'cltbld', 06:15:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:49 INFO - 'MOZ_NO_REMOTE': '1', 06:15:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:49 INFO - 'NO_EM_RESTART': '1', 06:15:49 INFO - 'PAGER': '/bin/cat', 06:15:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:49 INFO - 'PWD': '/builds/slave/test', 06:15:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:49 INFO - 'SHELL': '/bin/bash', 06:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AF38ed2ZWF/Listeners', 06:15:49 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 06:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:49 INFO - 'USER': 'cltbld', 06:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:49 INFO - 'XPC_FLAGS': '0x0', 06:15:49 INFO - 'XPC_SERVICE_NAME': '0', 06:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:15:49 INFO - mozversion application_buildid: 20161012030211 06:15:49 INFO - mozversion application_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 06:15:49 INFO - mozversion application_display_name: Nightly 06:15:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:49 INFO - mozversion application_name: Firefox 06:15:49 INFO - mozversion application_remotingname: firefox 06:15:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:15:49 INFO - mozversion application_vendor: Mozilla 06:15:49 INFO - mozversion application_version: 52.0a1 06:15:49 INFO - mozversion platform_buildid: 20161012030211 06:15:49 INFO - mozversion platform_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 06:15:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:15:49 INFO - mozversion platform_version: 52.0a1 06:15:49 INFO - using testdate: 1476278149 06:15:49 INFO - actual date: 1476278149 06:15:49 INFO - starting webserver on 'localhost:49269' 06:15:49 INFO - SUITE-START | Running 2 tests 06:15:49 INFO - TEST-START | dromaeo_css 06:15:49 INFO - operating with platform_type : mac_ 06:15:49 INFO - Initialising browser for dromaeo_css test... 06:15:49 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpvXO7oI/profile http://localhost:49269/getInfo.html) 06:15:52 INFO - PROCESS | 1654 | 2016-10-12 06:15:52.806 plugin-container[1657:7602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 06:15:52 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:52 INFO - PROCESS | 1654 | 2016-10-12 06:15:52.806 plugin-container[1657:7602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 06:15:52 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:52 INFO - PROCESS | 1654 | 2016-10-12 06:15:52.806 plugin-container[1657:7602] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:15:52 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 06:15:52 INFO - PROCESS | 1654 | colorDepth:24 06:15:52 INFO - PROCESS | 1654 | Browser inner width/height: 1024/663 06:15:52 INFO - PROCESS | 1654 | __metrics 06:15:52 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:15:53 INFO - TEST-INFO | 1654: exit 0 06:15:53 INFO - Browser initialized. 06:15:53 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:53 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpvXO7oI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:56 INFO - PROCESS | 1661 | 2016-10-12 06:15:56.520 plugin-container[1662:7783] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 06:15:56 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:56 INFO - PROCESS | 1661 | 2016-10-12 06:15:56.521 plugin-container[1662:7783] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 06:15:56 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:56 INFO - PROCESS | 1661 | 2016-10-12 06:15:56.521 plugin-container[1662:7783] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:16:06 INFO - PROCESS | 1661 | RSS: Main: 249380864 06:16:06 INFO - PROCESS | 1661 | 06:16:55 INFO - PROCESS | 1661 | 1476278215727 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:19:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 06:19:10 INFO - PROCESS | 1661 | RSS: Main: 260939776 06:19:10 INFO - PROCESS | 1661 | 06:22:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 06:22:12 INFO - PROCESS | 1661 | RSS: Main: 273936384 06:22:12 INFO - PROCESS | 1661 | 06:25:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 06:25:15 INFO - PROCESS | 1661 | RSS: Main: 277573632 06:25:15 INFO - PROCESS | 1661 | 06:28:17 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 06:28:17 INFO - PROCESS | 1661 | RSS: Main: 277209088 06:28:17 INFO - PROCESS | 1661 | 06:31:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 06:31:21 INFO - PROCESS | 1661 | RSS: Main: 282566656 06:31:21 INFO - PROCESS | 1661 | 06:34:23 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 06:34:24 INFO - PROCESS | 1661 | RSS: Main: 285081600 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | __start_tp_report 06:34:24 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 06:34:24 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 06:34:24 INFO - PROCESS | 1661 | |i|pagename|runs| 06:34:24 INFO - PROCESS | 1661 | |0;dojo.html;2790.288476438509;2836.8014239003273;3301.653326400726;3401.8639254429822;3413.2490852012565;5054.898902021962;5489.780408783654;5564.916526252109;5605.607607467479;5630;4977.925331120036;5140.717260550678;5532.446755324466;5611.971940140294;5682.6306290091115;4621.237495813187;5170;5212.1660534314515;5253.50091741284;5306.389765176996;5050.9898020395885;5226.477352264762;5258.579313654898;5266.52601265886;5307.734613269321;5036.798528058874;5096.031753966735;5128.769205385766;5177.870553236199;5203.323567936182;4212.936805947913;5164.122099243138;5166.147585648364;5180.1452760294505;5213.973930130325;5093.261477085802;5107.540321371094;5126.846194614168;5132.923006154911;5138.537531622134;5376.381716102659;5520.889582208373;5536.390996990368;5599.832005039855;5632.943670563324;6112.297085835142;6135.079738039285;6138.94021874843;6142.170806941051;6146.938530614726;6185.618511894635;6209.565330426872;6214.844628884269;6240.563160578761;6243.906341404882;5584.022796010722;5653.123765816264;5712.80005199816;5715.085586306171;5760.36635970043;6220.066989951543;6222.12890195373;6227;6233.252009758858;6236.594621349598;5976.882997624415;6059.606125601822;6092.482139018233;6107.633541987495;6124.899720463051;5356.276902618175;5775.306963164363;6044.909326360108;6086.261182467907;6132.233470816148;6074.4532992030045;6129.175413489998;6130.703893784946;6142.003848749175;6146.985747351637;6144.354842741537;6149.292831324366;6166.383361663888;6169.475594574512;6172.043333283348;4461.709988850715;4656.278276867091;4918.5573298403315;4927.408710954636;4929.654924155275;3809.4095415210686;4256.361545768098;4354.608085272341;4385.451818522684;4391.121775644884;5713.542916566665;5811.56413268998;5819.82540523785;5830.737616807254;5874.970625146847;6068.362821903725;6223.346548612421;6228.159198508143;6229.065640154013;6232;5638.069718496402;5756.913646295309;5775.913361299584;5795.710214489259;5857.414258574194;5373.032854086302;5377.3816011159215;5390.407055223922;5390.9191362129595;5422.15956526739;5207.427183009866;6199.907001394892;6278.0896769967185;6280.654563999024;6287.497000239879;5984.611000284967;6002.789902353396;6135.07973803933;6137.294211165773;6145.293291271382;6209.285932117864;6230.875382492415;6251.124842521959;6271.090691849748;6347.8095657128515;5997.430244126801;6049.30433000193;6121.540884433596;6134.4172303631085;6140.478059365004;6088.4215999479975;6110.953680641605;6111.287884814297;6125.998614523673;6192.752289908353;6049.3950604939155;6060.848478788065;6064.120702498201;6069.180660610761;6076.665783381956;6023.849403764941;6040.788572399945;6053.545984051126;6054.969725151346;6064.514838812973;4528.822506148491;5676.063449530946;5706.657600543981;5826.563007774349;5909;6034.63792172471;6035.064564992434;6055.333913269625;6058.4244496772735;6114.327423983447;5909.084091965752;5918.053111502139;5924.407559244041;5927.347991720821;5937.139114828239 06:34:24 INFO - PROCESS | 1661 | |1;ext.html;448.98877528061814;454.03970602176395;502.4297422425548;525.4246599973028;526.202802753828;37409.25181496368;39089.21821563567;39189.60810391895;39222.60777392225;39314.60685393145;34040.14899627511;40428.393574096415;40804.59195408045;41279;41307.793461032656;7990.880136797953;9411.529423528813;9561.043895610454;9610.663626773065;9619.615215391412;7318.6706598202945;8861.379703420764;8865.024847266795;9479;9580.137787599115;9572;9607.375520591175;9629.807403851919;9631.08504692053;9644.18024467921;9532.332736708433;9547.761305967406;9597.76005599862;9598.376105553116;9599.808003839884;9467.763305917339;9541.2367010639;9552.283578731553;9557.044295570457;9593.568289426992;38557.80721096405;38635.420468692995;38812.223755524734;38896.41655375172;38899.416508752394;3293.357795229931;3400.574928133983;3738.9439158412647;3814.4659747635355;4010.6791456683395;30039.5494067587;30409.847950760326;30642.23394415135;30666.386672266428;31217;3166.762492813048;3207.7113059824496;3229.11199420159;3296.2748195396975;3325.1354647791504;445222;476624;484402;503761;504306;53547.19679204815;53920.19119713207;54061.72969135129;54075.72962135243;54099.483533570194;55511;55713.442865570825;55975;56017.719911400185;56282.718586407624;15239.542813715607;15447.768283475756;15624.609384765472;15628.92185539065;15658.90387672852;12098.758024839453;12132.757344853053;12138.08964327679;12154.392280385946;12179.269243845398;14384;14454;14501.927490362481;14511.709765804624;14561.635959100895;5809.912851307234;5817.534597232211;6236.594621349598;6370.362963703686;6411.294757576663;814.9714759983373;914.7210100919284;951.70497145885;987.3461951231658;992.9453880036523;28452.146435606966;28607.42785144327;28901;29324.706752932623;29549.704502955126;1015.7917626886618;1018.9643362482277;1036.7459972306683;1058.380847204394;1142.9654267918688;13034;14779.852201477848;14797.852021479863;14963.40146394132;15229.771553426708;511852;650551;659429;661403;662142.3785762177;53051.46948530465;53292.46707532953;53435.46564534305;53450;53450;1271.1927925767204;1342.503273788685;1344.6302266876687;1348.8920886328874;1351.9121257118256;28013.439731205668;28117.859410702815;28319.575206371508;28542.57186142251;28922.710772892002;45191.54808452005;45430.77284613556;45585.088298234514;45605;45700;551435;553982;554337;555504;556706;24513.632295515938;25156.62265066062;36816.63183368132;37219.88340349794;37272.62727372692;30365.806738518637;35511.328138666286;35540.644593553734;45505;45547.772261139806;27987;31007.68992310048;34583.78956736502;35724.821375892956;37312.626873732;34109.46507407123;34302.313953721285;36838.44742328921;37122.25755484821;37998.43002354912;31964.200894976882;33684.326313474085;36759.89720308395;37271.81364093162;37962.43056354102;26245.475090498465;33468.66125355056;33889;34054.31891362208;34157.829210853786;22351.44121396978;23983.52032959296;24803.751962480143;24945.875270623532;25050.74949250557 06:34:24 INFO - PROCESS | 1661 | |2;jquery.html;330.4300082357932;365.99085022874425;367.3571250311953;380.34770368817505;400.4173926936308;18537.907310463444;19280.614387712238;19383.933883636393;19885.502862428446;20093.799062009377;19443.902780486078;19648.80351196491;19868.90065549674;19977.300794472198;20241;5506.91739623906;5532.3637781655225;5583.5254003409655;5865.912011319833;5875.001249787546;5672.602917795756;5821.654396707588;5822;5822.970885145568;5861.032929566616;5525.917111243334;5743.597948143632;5775.826725198251;5830.854228644296;5906.084556893688;4823.517648235166;5870.530357571405;5897.970510147422;5905.4685078343155;5907.7636894524385;4906.190478571068;5036.471170527078;5082.923756143661;5094.490550944913;5149.124648809674;21386.823724695136;21439.24962626316;21623.783762162333;24381.878090609433;24882.253532393876;2178.074318414683;2264.8449290861613;2268.829837762158;2334.7548507406646;2387.3673476528734;14631.122132672073;15254.38982440701;15343.944429174773;15377.923110384489;15565.844341556665;1569.607598100475;1797.4877160009464;1847.4827048426328;1851.685213513706;1870.494966359089;102080;105410.47294763477;105713.47143264311;108316.37525437125;109625.90374096237;9236.399634023766;10272.486375681186;10294.639687610897;10460.790784184273;10913;13289;13351.399187036606;13377.73244535104;13384.263865487297;13406.123142760021;6795.286494918061;6905.792826215222;8103;8379.539125348165;8431.60878455048;7857.646405911748;7888.698364769749;8450;8477.74566762998;8594.484330940164;6355.046742988497;6485.513586481033;6497.447716944018;6497.610143391412;6509.2839787623325;1809.9457016289268;1834.6239021000663;1855.9328386178001;1857.600615867595;1857.647047061054;881.5504092912661;891.3225948279224;945.1304799584399;953.7186529973675;1026.7022563456514;20162;20376.083076261602;21800.236991705533;21833.454163645718;21917.232896848534;919.3105171121658;941.5809964565702;957.3155194036298;959.472290240365;1039.5270152080784;8431.325493960469;10690.73273168177;11640.24338418017;11662.125340599488;11716.472758725708;583478;587734;592773;606644;607646;60789.392106079256;71569;82531;110108.4494577522;110930.44534777435;927.8077670193903;972.299944040304;992.6029588164791;1013.3919648211162;1033.194108595297;18629.813701862808;18797.154128063998;19159.52101197481;19178.616427671648;19241.51896202606;48027;49334.766630834514;49833.50166498288;51127.74436127795;51249.23126153185;69627.65186174036;69825.60348793097;69871.95192072225;69932.95100573597;70112.64943675249;7531.8117047074265;7691.346235570039;7768.417368697484;7919.881201782093;7966.083900351534;9943.404267972332;11902.40487975615;12266.815997760219;12312.199707019015;12431.011038233839;10345.482725863827;10846.945765271123;10976.615818446317;11008;11281.041111505285;9663.226941844776;10160.695179144637;10453.790924181625;10552.577896884039;10953.178511611502;9916.405015699082;10077.891431942628;10872.836907446237;11060.557577697124;11060.778784424105;6219.40915613016;7753.147153812964;7799.376049916106;7836.764897053097;7940.563269020028;10482.528286226985;10500.579976801147;10697.518611662339;10701.89298107009;10927.56289748433 06:34:24 INFO - PROCESS | 1661 | |3;mootools.html;1502.2563830903705;1531.9617009574758;1736.930522779089;1843.9539011524719;1845.0774612693663;7922.168172341908;8224.506529608228;8386.412951093418;8977;8987.550622468867;8383.958080209606;8723.171298726627;8737.519436430994;8868.600912958917;8874.112588741124;2286.3483907086484;2324.5118525109665;2326.232343326698;2330.650402439639;2336.509333040055;2292.9541409171807;2316.4787922717423;2342.941426464335;2349.9647505287435;2351.6590094436297;2305.5158416732506;2333.113416901575;2337.4740683346195;2337.555864385761;2340.847844890077;2283.3378320287097;2291.4844160064017;2292.197730794217;2295.931122066332;2299.9770002300015;2291.747907730148;2296.1045192374986;2302.6085565453914;2305.9308220753405;2306.342692332694;8824.602892869836;8869.556522173865;8906;8909.064548222474;8922.286217102615;5079.974600126976;5301.814436494743;5323.467653234684;5331.44019877915;5334.03987282289;3503.404421248394;3567.6075631680496;3682.429223470366;3699.7595156314756;3712.684421824148;1032.5560009196042;1072.6406653770996;1074.414444127952;1081.9675409737642;1096.3915027159924;10626.309289896131;11055.834162487568;11178.658560972654;11178.832317515244;11741.4716337765;3569.607343192247;3769.264993326275;3976.622220889011;4797.688150270221;4824.903501929942;9215.953920230357;9661.806763864683;9891.307608467338;9952.601895924083;9974.401535907724;5343.786248550092;5347.893042139135;5351.785928562892;5356.625036247426;5360.758765855546;4334.176506463762;4513.638908887281;4738.1708201064675;4843.539863712942;4934.605231581465;3826.9617303826603;3849.2301539692176;3950.30869597825;3973.2848087343978;3987.1228329767987;1261.993690031544;1274.5220542296638;1278;1280.5966120671958;1285.5950375631833;806.9919300807035;873.7640836973982;899.6851102114339;916.6333466613409;932.1750251027889;5806.21616081832;5810.6513609183585;5918.141869428909;6086.117512960596;6139.6009259398;897.2239013253619;898.7618281155499;900.6532484993194;908.4095338030334;977.3500622086375;3833.616638336144;3983.4423180754716;4011.939820902689;4047.008482921703;4054.2296963576828;9924.40453572788;10696.62561810333;10799.40603266828;10825.458727063615;10887.237893347548;10460.372377657364;10729.463526823627;10734.355938643706;10737.355758654505;10762.461876906124;8078.192180781874;8210.712625058095;8299.792505187419;8312.33501319893;8339.20777526134;4495.460544734653;5549.361823390362;5762.740676669476;5809.331926828469;5890.381509941566;9590.904090959;9891.799089675033;10096.69709908704;10097.899021009696;10135.847962280424;8513.74458766238;8612.440191387539;9759.658411955832;10034.749131271778;10319.690409287734;6835.658217089026;7042.894356584758;7273.163586187656;7434.36807871337;7621.352185064332;6745.628990405575;8224.958875205586;8411.579421029046;8420.663173472993;8479.61841717112;7400.925990740024;7448.6275686214385;7485.5508669480005;7534;7641;7187.209406965334;7260.16508101554;7286.817829554304;7402.518836275625;7402.777916662509;6919.515633905578;6936.0636314098965;6951.756688515878;7020.7542736004;7030.226675065841;4872.537108974641;4950.282209079735;4970.428400733962;4981.153203955264;5058.898822023612;4058.6144316289906;4900.068986892479;4921.827736029221;4993.825216117419;5034.974825125851 06:34:24 INFO - PROCESS | 1661 | |4;prototype.html;239.33226298626832;249.54458113942061;262.45802418006815;263.41784655910436;277.93468534894293;5338.371796602045;5427.213054107152;5477.917831232529;5479.698616576086;5498.972505137479;4750.501197374269;4895.437024742156;4927.408710954691;5328.227407025979;5409.810656627019;4149.3775933609895;4156.916861662765;4158.896027599304;4211.873643790684;4219.936700949488;3359.983200083996;3641.745077844552;4101.466809314785;4199.307114326132;4228.873133805991;4055.7363771354917;4078.632923036926;4081.8163182656704;4107.93193769619;4122.835086596548;3595.280943811235;3922.431027588959;4106.342985122396;4131.814068366901;4136.58634136587;3005.459017376871;3561.3767590671528;3569.232614987764;3569.607343192247;3574.2486181771005;4459.375687403766;4944.936838579687;5309.230161626542;5369.382521010095;5437.755301011464;3725.608811074825;4497.730136191839;4687.671862969593;4690.132325519756;4727.101850648366;5245.659032162897;5710.486056254916;5711.257536520267;5719.113537401709;5757.88484230313;3592.784432934006;3618.8733394331334;3721.274351501458;3756.9248615027545;3906.3554513505237;4933.407991041098;5563.638363506359;5778.3066032076;5970.761169553212;6037.30570984338;3790.5451345838674;3969.900752481211;3971.4837071180564;3973.324534829086;3998.8000599969887;3802.9161688918525;3869.9613003870163;3926.6073392660505;3968.8610898618986;4054.3107671695884;3870.8838734838;3939.625735555118;4661.463931647836;4696.835610753607;4738.668293219442;5861.794837180763;5866.354700982888;5879.589837894011;5895.970520147372;5917.733701983421;1161.8605767307808;1274.5088246751322;1317.7957416600443;1354.5800801751489;1364.6861221919014;809.6276810805628;867.2671592504324;896.8027034052498;915.2494954137676;916.9633214671472;5363.436839131913;5442.319710036246;5454.318210223722;5464.907018596296;5473;5385.892282154413;5881.676507792113;5886.381929897385;5903.291605007426;5939.821805345847;4556.589906908328;4744.857654270378;5291.947080529222;5315.255864179018;5420.674759514362;2016.2136766661015;2327.0226504867996;2352.6823878776145;2375.5130198309307;2631.6052492179174;4453.421055262795;4514.932276015862;5155.432902380735;5177.223416487482;5216.713080780593;4243.380326690373;4905.9018819624125;4935.014316338636;5024.422191447957;5068.161829375562;4667.323238130452;4733.5266473352385;4783.856484305476;5093.2105523643895;5146.897062058738;4126.649234815074;4489.775511224491;5000.449950505369;5000.499950004971;5019.824306149413;4532.9601679243815;4638.83764068256;4784.923392236719;4871.464138944642;4909.582685471775;4136.234796562646;4683.906321873612;5131.332926719502;5149.897002059863;5179.326687530597;2919.0588258808502;3216.485362342014;3308.42849646416;3429.7256219501883;3516.4197907346024;4395.648348132206;4850.684705494273;4958.76030992252;5015.64890457679;5044.369453818273;5683.374828768915;5728.627639203439;5737.5983681141915;5738.282714660668;5749.770009199585;4829.589484893823;5742.626729262584;5771.971140144273;5774.971125144348;5838;5442.782288708408;5555.910464630549;5628.549716022627;5688.317401911631;5712.914306285326;5184.7926082956255;5636.070048442125;5742.397048309867;5876.294844618502;5889.793857214977;5375.758635330521;5633.267675202197;5641.802536911188;5657.32112146545;5707.9429205709075 06:34:24 INFO - PROCESS | 1661 | |5;yui.html;584.3513699793228;675.7297081167529;717.58738725233;753.9331845438704;792.0930534537954;15018.624534386647;15381;15823.287952042172;15862.444814431497;16148.273327700252;14343.92828035861;14610.342534585943;14631.92684036581;14648.926755366208;14674.926625366857;655.6525041727868;685.8799710050746;827.5407149032285;844.8605980013291;845.1041895590663;803.5459965119718;826.2357319479457;827.2554700769325;835.8370117827026;842.7471758472465;888.6401007591936;900.3067637918798;900.6487469886749;902.3728508686465;905.8641203819446;877.2017464107663;889.1419779912351;890.9242714369286;892.7768057985504;894.1996912763041;640.8686219325027;657.8125234308247;663.051835874699;664.2925284571916;665.2648823050556;14621.12273263597;14762.778558321634;14809.629759255997;14812.963092583523;14837.48068817597;10735.62425315118;12544.874551254461;13739.519116830863;14537.418503259963;14697.55907322782;11502.482388292547;11577.359389422078;11624.767504649859;11634.59278925242;11834.05327573792;3693.4220869028827;3754.2303827715527;3771.0383852117807;3771.7171212159196;3783.1677031053123;109092.90907090907;109600;111297.44351278192;111532.4423377886;113175;9499.477528735848;11014.669559913216;11027.889721102847;11070.889291107147;11187.888121118847;22339.329820105424;22366.66450003251;22496.550068998527;22539.98570064351;22599.548009040056;7749.225077492319;7885.566293853778;7899.131095579482;7958.403119766041;8123.18768123183;4306.720063195945;4350.0647360817575;4388.319810429389;4397.780110994438;4512.097580483916;3496.4580490024086;3577.373959557119;3654.3056819204267;3663;3672.5225720656676;597.9551533634908;602.5872277489846;616.1312549305458;640.0175730254037;641.7304732012473;575.6143383932691;620.7051650465993;634.622048413443;637.6206157336377;639.9712012959428;8909.866352004725;9013.752416538793;9178.632854685738;9333.766655833522;9393.295502837314;559.5970900951309;620.8944479438507;640.2509064394576;644.7775517446568;645.0904225042667;3694.3165514379925;4039.7576145431367;4103.7742924138865;4199.811008504625;4209.873703788891;166346.1682691603;167664;169527;173290;174035;136197;136986;140970;142328;144821;114793.53842000243;119451.80548194407;120866.79133208732;122294;123727;7968.163342848918;7980.281774640311;7986.520808751494;8092.878606820785;8139.715109971123;48076.27885581789;62133.689331553054;64050.35949640444;65336;67672;99845.00154998357;100720;102488;102982;105386;10667.413292269;10702.946485267836;10739.194560407845;10809.783804324026;10820.350778953289;12762.680932976378;12783.80824287655;12816.807747883975;12862;12961.416736246703;11705.88294117082;11885.82171267449;12060.336681482602;12072.818907716215;12328.445219964944;11914.344711040976;11931.880681193077;11959.342236177094;12080.21478603888;12479.376031198586;11598.768024639628;11612.245204061708;12089.75820483603;12171.81742273849;12311.9384403081;7842.9607851962655;8361.581920903809;9159.86260206084;10128.797424051625;10603.045725884707;6905.413039891465;8880.51157186361;9311.44131352121;10332.431716255678;10343.224258180517 06:34:24 INFO - PROCESS | 1661 | __end_tp_report 06:34:24 INFO - PROCESS | 1661 | __start_cc_report 06:34:24 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,375 06:34:24 INFO - PROCESS | 1661 | __end_cc_report 06:34:24 INFO - PROCESS | 1661 | __startTimestamp1476279264066__endTimestamp 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | ------- Summary: start ------- 06:34:24 INFO - PROCESS | 1661 | Number of tests: 6 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5637.15 Median:5909.00 stddev:684.94 (11.6%) stddev-sans-first:649.62 06:34:24 INFO - PROCESS | 1661 | Values: 2790.3 2836.8 3301.7 3401.9 3413.2 5054.9 5489.8 5564.9 5605.6 5630.0 4977.9 5140.7 5532.4 5612.0 5682.6 4621.2 5170.0 5212.2 5253.5 5306.4 5051.0 5226.5 5258.6 5266.5 5307.7 5036.8 5096.0 5128.8 5177.9 5203.3 4212.9 5164.1 5166.1 5180.1 5214.0 5093.3 5107.5 5126.8 5132.9 5138.5 5376.4 5520.9 5536.4 5599.8 5632.9 6112.3 6135.1 6138.9 6142.2 6146.9 6185.6 6209.6 6214.8 6240.6 6243.9 5584.0 5653.1 5712.8 5715.1 5760.4 6220.1 6222.1 6227.0 6233.3 6236.6 5976.9 6059.6 6092.5 6107.6 6124.9 5356.3 5775.3 6044.9 6086.3 6132.2 6074.5 6129.2 6130.7 6142.0 6147.0 6144.4 6149.3 6166.4 6169.5 6172.0 4461.7 4656.3 4918.6 4927.4 4929.7 3809.4 4256.4 4354.6 4385.5 4391.1 5713.5 5811.6 5819.8 5830.7 5875.0 6068.4 6223.3 6228.2 6229.1 6232.0 5638.1 5756.9 5775.9 5795.7 5857.4 5373.0 5377.4 5390.4 5390.9 5422.2 5207.4 6199.9 6278.1 6280.7 6287.5 5984.6 6002.8 6135.1 6137.3 6145.3 6209.3 6230.9 6251.1 6271.1 6347.8 5997.4 6049.3 6121.5 6134.4 6140.5 6088.4 6111.0 6111.3 6126.0 6192.8 6049.4 6060.8 6064.1 6069.2 6076.7 6023.8 6040.8 6053.5 6055.0 6064.5 4528.8 5676.1 5706.7 5826.6 5909.0 6034.6 6035.1 6055.3 6058.4 6114.3 5909.1 5918.1 5924.4 5927.3 5937.1 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:67574.26 Median:38723.82 stddev:149780.63 (386.8%) stddev-sans-first:150116.02 06:34:24 INFO - PROCESS | 1661 | Values: 449.0 454.0 502.4 525.4 526.2 37409.3 39089.2 39189.6 39222.6 39314.6 34040.1 40428.4 40804.6 41279.0 41307.8 7990.9 9411.5 9561.0 9610.7 9619.6 7318.7 8861.4 8865.0 9479.0 9580.1 9572.0 9607.4 9629.8 9631.1 9644.2 9532.3 9547.8 9597.8 9598.4 9599.8 9467.8 9541.2 9552.3 9557.0 9593.6 38557.8 38635.4 38812.2 38896.4 38899.4 3293.4 3400.6 3738.9 3814.5 4010.7 30039.5 30409.8 30642.2 30666.4 31217.0 3166.8 3207.7 3229.1 3296.3 3325.1 445222.0 476624.0 484402.0 503761.0 504306.0 53547.2 53920.2 54061.7 54075.7 54099.5 55511.0 55713.4 55975.0 56017.7 56282.7 15239.5 15447.8 15624.6 15628.9 15658.9 12098.8 12132.8 12138.1 12154.4 12179.3 14384.0 14454.0 14501.9 14511.7 14561.6 5809.9 5817.5 6236.6 6370.4 6411.3 815.0 914.7 951.7 987.3 992.9 28452.1 28607.4 28901.0 29324.7 29549.7 1015.8 1019.0 1036.7 1058.4 1143.0 13034.0 14779.9 14797.9 14963.4 15229.8 511852.0 650551.0 659429.0 661403.0 662142.4 53051.5 53292.5 53435.5 53450.0 53450.0 1271.2 1342.5 1344.6 1348.9 1351.9 28013.4 28117.9 28319.6 28542.6 28922.7 45191.5 45430.8 45585.1 45605.0 45700.0 551435.0 553982.0 554337.0 555504.0 556706.0 24513.6 25156.6 36816.6 37219.9 37272.6 30365.8 35511.3 35540.6 45505.0 45547.8 27987.0 31007.7 34583.8 35724.8 37312.6 34109.5 34302.3 36838.4 37122.3 37998.4 31964.2 33684.3 36759.9 37271.8 37962.4 26245.5 33468.7 33889.0 34054.3 34157.8 22351.4 23983.5 24803.8 24945.9 25050.7 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33052.90 Median:12606.34 stddev:98315.31 (779.9%) stddev-sans-first:98560.41 06:34:24 INFO - PROCESS | 1661 | Values: 330.4 366.0 367.4 380.3 400.4 18537.9 19280.6 19383.9 19885.5 20093.8 19443.9 19648.8 19868.9 19977.3 20241.0 5506.9 5532.4 5583.5 5865.9 5875.0 5672.6 5821.7 5822.0 5823.0 5861.0 5525.9 5743.6 5775.8 5830.9 5906.1 4823.5 5870.5 5898.0 5905.5 5907.8 4906.2 5036.5 5082.9 5094.5 5149.1 21386.8 21439.2 21623.8 24381.9 24882.3 2178.1 2264.8 2268.8 2334.8 2387.4 14631.1 15254.4 15343.9 15377.9 15565.8 1569.6 1797.5 1847.5 1851.7 1870.5 102080.0 105410.5 105713.5 108316.4 109625.9 9236.4 10272.5 10294.6 10460.8 10913.0 13289.0 13351.4 13377.7 13384.3 13406.1 6795.3 6905.8 8103.0 8379.5 8431.6 7857.6 7888.7 8450.0 8477.7 8594.5 6355.0 6485.5 6497.4 6497.6 6509.3 1809.9 1834.6 1855.9 1857.6 1857.6 881.6 891.3 945.1 953.7 1026.7 20162.0 20376.1 21800.2 21833.5 21917.2 919.3 941.6 957.3 959.5 1039.5 8431.3 10690.7 11640.2 11662.1 11716.5 583478.0 587734.0 592773.0 606644.0 607646.0 60789.4 71569.0 82531.0 110108.4 110930.4 927.8 972.3 992.6 1013.4 1033.2 18629.8 18797.2 19159.5 19178.6 19241.5 48027.0 49334.8 49833.5 51127.7 51249.2 69627.7 69825.6 69872.0 69933.0 70112.6 7531.8 7691.3 7768.4 7919.9 7966.1 9943.4 11902.4 12266.8 12312.2 12431.0 10345.5 10846.9 10976.6 11008.0 11281.0 9663.2 10160.7 10453.8 10552.6 10953.2 9916.4 10077.9 10872.8 11060.6 11060.8 6219.4 7753.1 7799.4 7836.8 7940.6 10482.5 10500.6 10697.5 10701.9 10927.6 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5630.33 Median:4975.79 stddev:3147.34 (63.3%) stddev-sans-first:3140.88 06:34:24 INFO - PROCESS | 1661 | Values: 1502.3 1532.0 1736.9 1844.0 1845.1 7922.2 8224.5 8386.4 8977.0 8987.6 8384.0 8723.2 8737.5 8868.6 8874.1 2286.3 2324.5 2326.2 2330.7 2336.5 2293.0 2316.5 2342.9 2350.0 2351.7 2305.5 2333.1 2337.5 2337.6 2340.8 2283.3 2291.5 2292.2 2295.9 2300.0 2291.7 2296.1 2302.6 2305.9 2306.3 8824.6 8869.6 8906.0 8909.1 8922.3 5080.0 5301.8 5323.5 5331.4 5334.0 3503.4 3567.6 3682.4 3699.8 3712.7 1032.6 1072.6 1074.4 1082.0 1096.4 10626.3 11055.8 11178.7 11178.8 11741.5 3569.6 3769.3 3976.6 4797.7 4824.9 9216.0 9661.8 9891.3 9952.6 9974.4 5343.8 5347.9 5351.8 5356.6 5360.8 4334.2 4513.6 4738.2 4843.5 4934.6 3827.0 3849.2 3950.3 3973.3 3987.1 1262.0 1274.5 1278.0 1280.6 1285.6 807.0 873.8 899.7 916.6 932.2 5806.2 5810.7 5918.1 6086.1 6139.6 897.2 898.8 900.7 908.4 977.4 3833.6 3983.4 4011.9 4047.0 4054.2 9924.4 10696.6 10799.4 10825.5 10887.2 10460.4 10729.5 10734.4 10737.4 10762.5 8078.2 8210.7 8299.8 8312.3 8339.2 4495.5 5549.4 5762.7 5809.3 5890.4 9590.9 9891.8 10096.7 10097.9 10135.8 8513.7 8612.4 9759.7 10034.7 10319.7 6835.7 7042.9 7273.2 7434.4 7621.4 6745.6 8225.0 8411.6 8420.7 8479.6 7400.9 7448.6 7485.6 7534.0 7641.0 7187.2 7260.2 7286.8 7402.5 7402.8 6919.5 6936.1 6951.8 7020.8 7030.2 4872.5 4950.3 4970.4 4981.2 5058.9 4058.6 4900.1 4921.8 4993.8 5035.0 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4421.71 Median:4883.45 stddev:1386.99 (28.4%) stddev-sans-first:1354.89 06:34:24 INFO - PROCESS | 1661 | Values: 239.3 249.5 262.5 263.4 277.9 5338.4 5427.2 5477.9 5479.7 5499.0 4750.5 4895.4 4927.4 5328.2 5409.8 4149.4 4156.9 4158.9 4211.9 4219.9 3360.0 3641.7 4101.5 4199.3 4228.9 4055.7 4078.6 4081.8 4107.9 4122.8 3595.3 3922.4 4106.3 4131.8 4136.6 3005.5 3561.4 3569.2 3569.6 3574.2 4459.4 4944.9 5309.2 5369.4 5437.8 3725.6 4497.7 4687.7 4690.1 4727.1 5245.7 5710.5 5711.3 5719.1 5757.9 3592.8 3618.9 3721.3 3756.9 3906.4 4933.4 5563.6 5778.3 5970.8 6037.3 3790.5 3969.9 3971.5 3973.3 3998.8 3802.9 3870.0 3926.6 3968.9 4054.3 3870.9 3939.6 4661.5 4696.8 4738.7 5861.8 5866.4 5879.6 5896.0 5917.7 1161.9 1274.5 1317.8 1354.6 1364.7 809.6 867.3 896.8 915.2 917.0 5363.4 5442.3 5454.3 5464.9 5473.0 5385.9 5881.7 5886.4 5903.3 5939.8 4556.6 4744.9 5291.9 5315.3 5420.7 2016.2 2327.0 2352.7 2375.5 2631.6 4453.4 4514.9 5155.4 5177.2 5216.7 4243.4 4905.9 4935.0 5024.4 5068.2 4667.3 4733.5 4783.9 5093.2 5146.9 4126.6 4489.8 5000.4 5000.5 5019.8 4533.0 4638.8 4784.9 4871.5 4909.6 4136.2 4683.9 5131.3 5149.9 5179.3 2919.1 3216.5 3308.4 3429.7 3516.4 4395.6 4850.7 4958.8 5015.6 5044.4 5683.4 5728.6 5737.6 5738.3 5749.8 4829.6 5742.6 5772.0 5775.0 5838.0 5442.8 5555.9 5628.5 5688.3 5712.9 5184.8 5636.1 5742.4 5876.3 5889.8 5375.8 5633.3 5641.8 5657.3 5707.9 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:25944.24 Median:3667.76 stddev:43665.06 (1190.5%) stddev-sans-first:43746.04 06:34:24 INFO - PROCESS | 1661 | Values: 584.4 675.7 717.6 753.9 792.1 15018.6 15381.0 15823.3 15862.4 16148.3 14343.9 14610.3 14631.9 14648.9 14674.9 655.7 685.9 827.5 844.9 845.1 803.5 826.2 827.3 835.8 842.7 888.6 900.3 900.6 902.4 905.9 877.2 889.1 890.9 892.8 894.2 640.9 657.8 663.1 664.3 665.3 14621.1 14762.8 14809.6 14813.0 14837.5 10735.6 12544.9 13739.5 14537.4 14697.6 11502.5 11577.4 11624.8 11634.6 11834.1 3693.4 3754.2 3771.0 3771.7 3783.2 109092.9 109600.0 111297.4 111532.4 113175.0 9499.5 11014.7 11027.9 11070.9 11187.9 22339.3 22366.7 22496.6 22540.0 22599.5 7749.2 7885.6 7899.1 7958.4 8123.2 4306.7 4350.1 4388.3 4397.8 4512.1 3496.5 3577.4 3654.3 3663.0 3672.5 598.0 602.6 616.1 640.0 641.7 575.6 620.7 634.6 637.6 640.0 8909.9 9013.8 9178.6 9333.8 9393.3 559.6 620.9 640.3 644.8 645.1 3694.3 4039.8 4103.8 4199.8 4209.9 166346.2 167664.0 169527.0 173290.0 174035.0 136197.0 136986.0 140970.0 142328.0 144821.0 114793.5 119451.8 120866.8 122294.0 123727.0 7968.2 7980.3 7986.5 8092.9 8139.7 48076.3 62133.7 64050.4 65336.0 67672.0 99845.0 100720.0 102488.0 102982.0 105386.0 10667.4 10702.9 10739.2 10809.8 10820.4 12762.7 12783.8 12816.8 12862.0 12961.4 11705.9 11885.8 12060.3 12072.8 12328.4 11914.3 11931.9 11959.3 12080.2 12479.4 11598.8 11612.2 12089.8 12171.8 12311.9 7843.0 8361.6 9159.9 10128.8 10603.0 6905.4 8880.5 9311.4 10332.4 10343.2 06:34:24 INFO - PROCESS | 1661 | -------- Summary: end -------- 06:34:24 INFO - PROCESS | 1661 | 06:34:24 INFO - TEST-INFO | 1661: exit 0 06:34:24 INFO - TEST-OK | dromaeo_css | took 1115105ms 06:34:24 INFO - TEST-START | kraken 06:34:24 INFO - operating with platform_type : mac_ 06:34:24 INFO - Initialising browser for kraken test... 06:34:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpLcxeed/profile http://localhost:49269/getInfo.html) 06:34:27 INFO - PROCESS | 1671 | 2016-10-12 06:34:27.283 plugin-container[1673:9932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 06:34:27 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:34:27 INFO - PROCESS | 1671 | 2016-10-12 06:34:27.285 plugin-container[1673:9932] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:34:27 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:34:27 INFO - PROCESS | 1671 | 2016-10-12 06:34:27.285 plugin-container[1673:9932] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:34:27 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 06:34:27 INFO - PROCESS | 1671 | colorDepth:24 06:34:27 INFO - PROCESS | 1671 | Browser inner width/height: 1024/663 06:34:27 INFO - PROCESS | 1671 | __metrics 06:34:27 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 06:34:28 INFO - TEST-INFO | 1671: exit 0 06:34:28 INFO - Browser initialized. 06:34:28 INFO - Running cycle 1/1 for kraken test... 06:34:28 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmpLcxeed/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:30 INFO - PROCESS | 1674 | 2016-10-12 06:34:30.697 plugin-container[1675:10049] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882f, name = 'com.apple.tsm.portname' 06:34:30 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:34:30 INFO - PROCESS | 1674 | 2016-10-12 06:34:30.697 plugin-container[1675:10049] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:34:30 INFO - PROCESS | 1674 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:34:30 INFO - PROCESS | 1674 | 2016-10-12 06:34:30.697 plugin-container[1675:10049] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:34:40 INFO - PROCESS | 1674 | RSS: Main: 246960128 06:34:40 INFO - PROCESS | 1674 | 06:34:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:44 INFO - PROCESS | 1674 | RSS: Main: 257978368 06:34:44 INFO - PROCESS | 1674 | 06:34:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 06:34:47 INFO - PROCESS | 1674 | RSS: Main: 265486336 06:34:47 INFO - PROCESS | 1674 | 06:34:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 06:34:51 INFO - PROCESS | 1674 | RSS: Main: 263921664 06:34:51 INFO - PROCESS | 1674 | 06:34:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 06:34:54 INFO - PROCESS | 1674 | RSS: Main: 265392128 06:34:54 INFO - PROCESS | 1674 | 06:34:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:56 INFO - PROCESS | 1674 | RSS: Main: 265682944 06:34:56 INFO - PROCESS | 1674 | 06:34:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:00 INFO - PROCESS | 1674 | RSS: Main: 266317824 06:35:00 INFO - PROCESS | 1674 | 06:35:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:04 INFO - PROCESS | 1674 | RSS: Main: 266006528 06:35:04 INFO - PROCESS | 1674 | 06:35:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 06:35:07 INFO - PROCESS | 1674 | RSS: Main: 266067968 06:35:07 INFO - PROCESS | 1674 | 06:35:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:09 INFO - PROCESS | 1674 | RSS: Main: 265854976 06:35:09 INFO - PROCESS | 1674 | 06:35:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:12 INFO - PROCESS | 1674 | RSS: Main: 265977856 06:35:12 INFO - PROCESS | 1674 | 06:35:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:15 INFO - PROCESS | 1674 | RSS: Main: 265953280 06:35:15 INFO - PROCESS | 1674 | 06:35:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:19 INFO - PROCESS | 1674 | RSS: Main: 266285056 06:35:19 INFO - PROCESS | 1674 | 06:35:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:22 INFO - PROCESS | 1674 | RSS: Main: 266371072 06:35:22 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 06:35:24 INFO - PROCESS | 1674 | RSS: Main: 267907072 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | __start_tp_report 06:35:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 06:35:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 06:35:24 INFO - PROCESS | 1674 | |i|pagename|runs| 06:35:24 INFO - PROCESS | 1674 | |0;ai-astar;104;117;116;110;106;143;133;152;173;168 06:35:24 INFO - PROCESS | 1674 | |1;audio-beat-detection;150;117;154;141;107;131;110;113;166;105 06:35:24 INFO - PROCESS | 1674 | |2;audio-dft;195;207;219;269;218;199;195;200;202;276 06:35:24 INFO - PROCESS | 1674 | |3;audio-fft;82;58;76;107;89;84;68;62;77;59 06:35:24 INFO - PROCESS | 1674 | |4;audio-oscillator;83;70;87;74;71;84;73;90;102;72 06:35:24 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;88;89;87;91;85;126;133;134;131 06:35:24 INFO - PROCESS | 1674 | |6;imaging-darkroom;149;151;96;95;126;90;137;150;134;94 06:35:24 INFO - PROCESS | 1674 | |7;imaging-desaturate;91;96;91;90;91;91;90;93;90;88 06:35:24 INFO - PROCESS | 1674 | |8;json-parse-financial;58;56;58;57;55;57;57;59;56;58 06:35:24 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;70;75;72;83;77;69;70;90;108;111 06:35:24 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;90;86;94;89;101;82;90;87;91;95 06:35:24 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;152;154;164;160;164;147;149;169;194;165 06:35:24 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;172;174;172;176;174;172;175;173;175;174 06:35:24 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;86;91;93;91;91;63;80;90;89 06:35:24 INFO - PROCESS | 1674 | __end_tp_report 06:35:24 INFO - PROCESS | 1674 | __start_cc_report 06:35:24 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,969 06:35:24 INFO - PROCESS | 1674 | __end_cc_report 06:35:24 INFO - PROCESS | 1674 | __startTimestamp1476279324897__endTimestamp 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | ------- Summary: start ------- 06:35:24 INFO - PROCESS | 1674 | Number of tests: 14 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:132.20 Median:138.00 stddev:25.65 (18.6%) stddev-sans-first:25.10 06:35:24 INFO - PROCESS | 1674 | Values: 104.0 117.0 116.0 110.0 106.0 143.0 133.0 152.0 173.0 168.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:136.00 stddev:22.12 (16.3%) stddev-sans-first:22.17 06:35:24 INFO - PROCESS | 1674 | Values: 150.0 117.0 154.0 141.0 107.0 131.0 110.0 113.0 166.0 105.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:218.00 Median:212.50 stddev:29.97 (14.1%) stddev-sans-first:30.61 06:35:24 INFO - PROCESS | 1674 | Values: 195.0 207.0 219.0 269.0 218.0 199.0 195.0 200.0 202.0 276.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:76.20 Median:76.50 stddev:15.29 (20.0%) stddev-sans-first:16.07 06:35:24 INFO - PROCESS | 1674 | Values: 82.0 58.0 76.0 107.0 89.0 84.0 68.0 62.0 77.0 59.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:78.50 stddev:10.46 (13.3%) stddev-sans-first:11.06 06:35:24 INFO - PROCESS | 1674 | Values: 83.0 70.0 87.0 74.0 71.0 84.0 73.0 90.0 102.0 72.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:105.20 Median:87.50 stddev:22.35 (25.5%) stddev-sans-first:22.82 06:35:24 INFO - PROCESS | 1674 | Values: 88.0 88.0 89.0 87.0 91.0 85.0 126.0 133.0 134.0 131.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:122.20 Median:120.50 stddev:25.72 (21.3%) stddev-sans-first:25.38 06:35:24 INFO - PROCESS | 1674 | Values: 149.0 151.0 96.0 95.0 126.0 90.0 137.0 150.0 134.0 94.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:91.00 stddev:2.13 (2.3%) stddev-sans-first:2.26 06:35:24 INFO - PROCESS | 1674 | Values: 91.0 96.0 91.0 90.0 91.0 91.0 90.0 93.0 90.0 88.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:1.20 (2.1%) stddev-sans-first:1.22 06:35:24 INFO - PROCESS | 1674 | Values: 58.0 56.0 58.0 57.0 55.0 57.0 57.0 59.0 56.0 58.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:73.50 stddev:15.67 (21.3%) stddev-sans-first:15.96 06:35:24 INFO - PROCESS | 1674 | Values: 70.0 75.0 72.0 83.0 77.0 69.0 70.0 90.0 108.0 111.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:90.00 stddev:5.28 (5.9%) stddev-sans-first:5.59 06:35:24 INFO - PROCESS | 1674 | Values: 90.0 86.0 94.0 89.0 101.0 82.0 90.0 87.0 91.0 95.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:164.00 stddev:13.55 (8.3%) stddev-sans-first:13.90 06:35:24 INFO - PROCESS | 1674 | Values: 152.0 154.0 164.0 160.0 164.0 147.0 149.0 169.0 194.0 165.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:1.42 (0.8%) stddev-sans-first:1.36 06:35:24 INFO - PROCESS | 1674 | Values: 172.0 174.0 172.0 176.0 174.0 172.0 175.0 173.0 175.0 174.0 06:35:24 INFO - PROCESS | 1674 | 06:35:24 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.10 Median:90.50 stddev:10.74 (11.9%) stddev-sans-first:9.45 06:35:24 INFO - PROCESS | 1674 | Values: 67.0 86.0 91.0 93.0 91.0 91.0 63.0 80.0 90.0 89.0 06:35:24 INFO - PROCESS | 1674 | -------- Summary: end -------- 06:35:24 INFO - PROCESS | 1674 | 06:35:25 INFO - TEST-INFO | 1674: exit 0 06:35:25 INFO - TEST-OK | kraken | took 61223ms 06:35:25 INFO - SUITE-END | took 1176s 06:35:26 INFO - Completed test suite (00:19:36) 06:35:26 INFO - javascript benchmark 06:35:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7153.847493243777, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2790.288476438509, 2836.8014239003273, 3301.653326400726, 3401.8639254429822, 3413.2490852012565, 5054.898902021962, 5489.780408783654, 5564.916526252109, 5605.607607467479, 5630.0, 4977.925331120036, 5140.717260550678, 5532.446755324466, 5611.971940140294, 5682.6306290091115, 4621.237495813187, 5170.0, 5212.1660534314515, 5253.50091741284, 5306.389765176996, 5050.9898020395885, 5226.477352264762, 5258.579313654898, 5266.52601265886, 5307.734613269321, 5036.798528058874, 5096.031753966735, 5128.769205385766, 5177.870553236199, 5203.323567936182, 4212.936805947913, 5164.122099243138, 5166.147585648364, 5180.1452760294505, 5213.973930130325, 5093.261477085802, 5107.540321371094, 5126.846194614168, 5132.923006154911, 5138.537531622134, 5376.381716102659, 5520.889582208373, 5536.390996990368, 5599.832005039855, 5632.943670563324, 6112.297085835142, 6135.079738039285, 6138.94021874843, 6142.170806941051, 6146.938530614726, 6185.618511894635, 6209.565330426872, 6214.844628884269, 6240.563160578761, 6243.906341404882, 5584.022796010722, 5653.123765816264, 5712.80005199816, 5715.085586306171, 5760.36635970043, 6220.066989951543, 6222.12890195373, 6227.0, 6233.252009758858, 6236.594621349598, 5976.882997624415, 6059.606125601822, 6092.482139018233, 6107.633541987495, 6124.899720463051, 5356.276902618175, 5775.306963164363, 6044.909326360108, 6086.261182467907, 6132.233470816148, 6074.4532992030045, 6129.175413489998, 6130.703893784946, 6142.003848749175, 6146.985747351637, 6144.354842741537, 6149.292831324366, 6166.383361663888, 6169.475594574512, 6172.043333283348, 4461.709988850715, 4656.278276867091, 4918.5573298403315, 4927.408710954636, 4929.654924155275, 3809.4095415210686, 4256.361545768098, 4354.608085272341, 4385.451818522684, 4391.121775644884, 5713.542916566665, 5811.56413268998, 5819.82540523785, 5830.737616807254, 5874.970625146847, 6068.362821903725, 6223.346548612421, 6228.159198508143, 6229.065640154013, 6232.0, 5638.069718496402, 5756.913646295309, 5775.913361299584, 5795.710214489259, 5857.414258574194, 5373.032854086302, 5377.3816011159215, 5390.407055223922, 5390.9191362129595, 5422.15956526739, 5207.427183009866, 6199.907001394892, 6278.0896769967185, 6280.654563999024, 6287.497000239879, 5984.611000284967, 6002.789902353396, 6135.07973803933, 6137.294211165773, 6145.293291271382, 6209.285932117864, 6230.875382492415, 6251.124842521959, 6271.090691849748, 6347.8095657128515, 5997.430244126801, 6049.30433000193, 6121.540884433596, 6134.4172303631085, 6140.478059365004, 6088.4215999479975, 6110.953680641605, 6111.287884814297, 6125.998614523673, 6192.752289908353, 6049.3950604939155, 6060.848478788065, 6064.120702498201, 6069.180660610761, 6076.665783381956, 6023.849403764941, 6040.788572399945, 6053.545984051126, 6054.969725151346, 6064.514838812973, 4528.822506148491, 5676.063449530946, 5706.657600543981, 5826.563007774349, 5909.0, 6034.63792172471, 6035.064564992434, 6055.333913269625, 6058.4244496772735, 6114.327423983447, 5909.084091965752, 5918.053111502139, 5924.407559244041, 5927.347991720821, 5937.139114828239], "value": 5590.4386901703965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.98877528061814, 454.03970602176395, 502.4297422425548, 525.4246599973028, 526.202802753828, 37409.25181496368, 39089.21821563567, 39189.60810391895, 39222.60777392225, 39314.60685393145, 34040.14899627511, 40428.393574096415, 40804.59195408045, 41279.0, 41307.793461032656, 7990.880136797953, 9411.529423528813, 9561.043895610454, 9610.663626773065, 9619.615215391412, 7318.6706598202945, 8861.379703420764, 8865.024847266795, 9479.0, 9580.137787599115, 9572.0, 9607.375520591175, 9629.807403851919, 9631.08504692053, 9644.18024467921, 9532.332736708433, 9547.761305967406, 9597.76005599862, 9598.376105553116, 9599.808003839884, 9467.763305917339, 9541.2367010639, 9552.283578731553, 9557.044295570457, 9593.568289426992, 38557.80721096405, 38635.420468692995, 38812.223755524734, 38896.41655375172, 38899.416508752394, 3293.357795229931, 3400.574928133983, 3738.9439158412647, 3814.4659747635355, 4010.6791456683395, 30039.5494067587, 30409.847950760326, 30642.23394415135, 30666.386672266428, 31217.0, 3166.762492813048, 3207.7113059824496, 3229.11199420159, 3296.2748195396975, 3325.1354647791504, 445222.0, 476624.0, 484402.0, 503761.0, 504306.0, 53547.19679204815, 53920.19119713207, 54061.72969135129, 54075.72962135243, 54099.483533570194, 55511.0, 55713.442865570825, 55975.0, 56017.719911400185, 56282.718586407624, 15239.542813715607, 15447.768283475756, 15624.609384765472, 15628.92185539065, 15658.90387672852, 12098.758024839453, 12132.757344853053, 12138.08964327679, 12154.392280385946, 12179.269243845398, 14384.0, 14454.0, 14501.927490362481, 14511.709765804624, 14561.635959100895, 5809.912851307234, 5817.534597232211, 6236.594621349598, 6370.362963703686, 6411.294757576663, 814.9714759983373, 914.7210100919284, 951.70497145885, 987.3461951231658, 992.9453880036523, 28452.146435606966, 28607.42785144327, 28901.0, 29324.706752932623, 29549.704502955126, 1015.7917626886618, 1018.9643362482277, 1036.7459972306683, 1058.380847204394, 1142.9654267918688, 13034.0, 14779.852201477848, 14797.852021479863, 14963.40146394132, 15229.771553426708, 511852.0, 650551.0, 659429.0, 661403.0, 662142.3785762177, 53051.46948530465, 53292.46707532953, 53435.46564534305, 53450.0, 53450.0, 1271.1927925767204, 1342.503273788685, 1344.6302266876687, 1348.8920886328874, 1351.9121257118256, 28013.439731205668, 28117.859410702815, 28319.575206371508, 28542.57186142251, 28922.710772892002, 45191.54808452005, 45430.77284613556, 45585.088298234514, 45605.0, 45700.0, 551435.0, 553982.0, 554337.0, 555504.0, 556706.0, 24513.632295515938, 25156.62265066062, 36816.63183368132, 37219.88340349794, 37272.62727372692, 30365.806738518637, 35511.328138666286, 35540.644593553734, 45505.0, 45547.772261139806, 27987.0, 31007.68992310048, 34583.78956736502, 35724.821375892956, 37312.626873732, 34109.46507407123, 34302.313953721285, 36838.44742328921, 37122.25755484821, 37998.43002354912, 31964.200894976882, 33684.326313474085, 36759.89720308395, 37271.81364093162, 37962.43056354102, 26245.475090498465, 33468.66125355056, 33889.0, 34054.31891362208, 34157.829210853786, 22351.44121396978, 23983.52032959296, 24803.751962480143, 24945.875270623532, 25050.74949250557], "value": 18970.026791928758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4300082357932, 365.99085022874425, 367.3571250311953, 380.34770368817505, 400.4173926936308, 18537.907310463444, 19280.614387712238, 19383.933883636393, 19885.502862428446, 20093.799062009377, 19443.902780486078, 19648.80351196491, 19868.90065549674, 19977.300794472198, 20241.0, 5506.91739623906, 5532.3637781655225, 5583.5254003409655, 5865.912011319833, 5875.001249787546, 5672.602917795756, 5821.654396707588, 5822.0, 5822.970885145568, 5861.032929566616, 5525.917111243334, 5743.597948143632, 5775.826725198251, 5830.854228644296, 5906.084556893688, 4823.517648235166, 5870.530357571405, 5897.970510147422, 5905.4685078343155, 5907.7636894524385, 4906.190478571068, 5036.471170527078, 5082.923756143661, 5094.490550944913, 5149.124648809674, 21386.823724695136, 21439.24962626316, 21623.783762162333, 24381.878090609433, 24882.253532393876, 2178.074318414683, 2264.8449290861613, 2268.829837762158, 2334.7548507406646, 2387.3673476528734, 14631.122132672073, 15254.38982440701, 15343.944429174773, 15377.923110384489, 15565.844341556665, 1569.607598100475, 1797.4877160009464, 1847.4827048426328, 1851.685213513706, 1870.494966359089, 102080.0, 105410.47294763477, 105713.47143264311, 108316.37525437125, 109625.90374096237, 9236.399634023766, 10272.486375681186, 10294.639687610897, 10460.790784184273, 10913.0, 13289.0, 13351.399187036606, 13377.73244535104, 13384.263865487297, 13406.123142760021, 6795.286494918061, 6905.792826215222, 8103.0, 8379.539125348165, 8431.60878455048, 7857.646405911748, 7888.698364769749, 8450.0, 8477.74566762998, 8594.484330940164, 6355.046742988497, 6485.513586481033, 6497.447716944018, 6497.610143391412, 6509.2839787623325, 1809.9457016289268, 1834.6239021000663, 1855.9328386178001, 1857.600615867595, 1857.647047061054, 881.5504092912661, 891.3225948279224, 945.1304799584399, 953.7186529973675, 1026.7022563456514, 20162.0, 20376.083076261602, 21800.236991705533, 21833.454163645718, 21917.232896848534, 919.3105171121658, 941.5809964565702, 957.3155194036298, 959.472290240365, 1039.5270152080784, 8431.325493960469, 10690.73273168177, 11640.24338418017, 11662.125340599488, 11716.472758725708, 583478.0, 587734.0, 592773.0, 606644.0, 607646.0, 60789.392106079256, 71569.0, 82531.0, 110108.4494577522, 110930.44534777435, 927.8077670193903, 972.299944040304, 992.6029588164791, 1013.3919648211162, 1033.194108595297, 18629.813701862808, 18797.154128063998, 19159.52101197481, 19178.616427671648, 19241.51896202606, 48027.0, 49334.766630834514, 49833.50166498288, 51127.74436127795, 51249.23126153185, 69627.65186174036, 69825.60348793097, 69871.95192072225, 69932.95100573597, 70112.64943675249, 7531.8117047074265, 7691.346235570039, 7768.417368697484, 7919.881201782093, 7966.083900351534, 9943.404267972332, 11902.40487975615, 12266.815997760219, 12312.199707019015, 12431.011038233839, 10345.482725863827, 10846.945765271123, 10976.615818446317, 11008.0, 11281.041111505285, 9663.226941844776, 10160.695179144637, 10453.790924181625, 10552.577896884039, 10953.178511611502, 9916.405015699082, 10077.891431942628, 10872.836907446237, 11060.557577697124, 11060.778784424105, 6219.40915613016, 7753.147153812964, 7799.376049916106, 7836.764897053097, 7940.563269020028, 10482.528286226985, 10500.579976801147, 10697.518611662339, 10701.89298107009, 10927.56289748433], "value": 9307.098074929576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.2563830903705, 1531.9617009574758, 1736.930522779089, 1843.9539011524719, 1845.0774612693663, 7922.168172341908, 8224.506529608228, 8386.412951093418, 8977.0, 8987.550622468867, 8383.958080209606, 8723.171298726627, 8737.519436430994, 8868.600912958917, 8874.112588741124, 2286.3483907086484, 2324.5118525109665, 2326.232343326698, 2330.650402439639, 2336.509333040055, 2292.9541409171807, 2316.4787922717423, 2342.941426464335, 2349.9647505287435, 2351.6590094436297, 2305.5158416732506, 2333.113416901575, 2337.4740683346195, 2337.555864385761, 2340.847844890077, 2283.3378320287097, 2291.4844160064017, 2292.197730794217, 2295.931122066332, 2299.9770002300015, 2291.747907730148, 2296.1045192374986, 2302.6085565453914, 2305.9308220753405, 2306.342692332694, 8824.602892869836, 8869.556522173865, 8906.0, 8909.064548222474, 8922.286217102615, 5079.974600126976, 5301.814436494743, 5323.467653234684, 5331.44019877915, 5334.03987282289, 3503.404421248394, 3567.6075631680496, 3682.429223470366, 3699.7595156314756, 3712.684421824148, 1032.5560009196042, 1072.6406653770996, 1074.414444127952, 1081.9675409737642, 1096.3915027159924, 10626.309289896131, 11055.834162487568, 11178.658560972654, 11178.832317515244, 11741.4716337765, 3569.607343192247, 3769.264993326275, 3976.622220889011, 4797.688150270221, 4824.903501929942, 9215.953920230357, 9661.806763864683, 9891.307608467338, 9952.601895924083, 9974.401535907724, 5343.786248550092, 5347.893042139135, 5351.785928562892, 5356.625036247426, 5360.758765855546, 4334.176506463762, 4513.638908887281, 4738.1708201064675, 4843.539863712942, 4934.605231581465, 3826.9617303826603, 3849.2301539692176, 3950.30869597825, 3973.2848087343978, 3987.1228329767987, 1261.993690031544, 1274.5220542296638, 1278.0, 1280.5966120671958, 1285.5950375631833, 806.9919300807035, 873.7640836973982, 899.6851102114339, 916.6333466613409, 932.1750251027889, 5806.21616081832, 5810.6513609183585, 5918.141869428909, 6086.117512960596, 6139.6009259398, 897.2239013253619, 898.7618281155499, 900.6532484993194, 908.4095338030334, 977.3500622086375, 3833.616638336144, 3983.4423180754716, 4011.939820902689, 4047.008482921703, 4054.2296963576828, 9924.40453572788, 10696.62561810333, 10799.40603266828, 10825.458727063615, 10887.237893347548, 10460.372377657364, 10729.463526823627, 10734.355938643706, 10737.355758654505, 10762.461876906124, 8078.192180781874, 8210.712625058095, 8299.792505187419, 8312.33501319893, 8339.20777526134, 4495.460544734653, 5549.361823390362, 5762.740676669476, 5809.331926828469, 5890.381509941566, 9590.904090959, 9891.799089675033, 10096.69709908704, 10097.899021009696, 10135.847962280424, 8513.74458766238, 8612.440191387539, 9759.658411955832, 10034.749131271778, 10319.690409287734, 6835.658217089026, 7042.894356584758, 7273.163586187656, 7434.36807871337, 7621.352185064332, 6745.628990405575, 8224.958875205586, 8411.579421029046, 8420.663173472993, 8479.61841717112, 7400.925990740024, 7448.6275686214385, 7485.5508669480005, 7534.0, 7641.0, 7187.209406965334, 7260.16508101554, 7286.817829554304, 7402.518836275625, 7402.777916662509, 6919.515633905578, 6936.0636314098965, 6951.756688515878, 7020.7542736004, 7030.226675065841, 4872.537108974641, 4950.282209079735, 4970.428400733962, 4981.153203955264, 5058.898822023612, 4058.6144316289906, 4900.068986892479, 4921.827736029221, 4993.825216117419, 5034.974825125851], "value": 4533.848946709158, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [239.33226298626832, 249.54458113942061, 262.45802418006815, 263.41784655910436, 277.93468534894293, 5338.371796602045, 5427.213054107152, 5477.917831232529, 5479.698616576086, 5498.972505137479, 4750.501197374269, 4895.437024742156, 4927.408710954691, 5328.227407025979, 5409.810656627019, 4149.3775933609895, 4156.916861662765, 4158.896027599304, 4211.873643790684, 4219.936700949488, 3359.983200083996, 3641.745077844552, 4101.466809314785, 4199.307114326132, 4228.873133805991, 4055.7363771354917, 4078.632923036926, 4081.8163182656704, 4107.93193769619, 4122.835086596548, 3595.280943811235, 3922.431027588959, 4106.342985122396, 4131.814068366901, 4136.58634136587, 3005.459017376871, 3561.3767590671528, 3569.232614987764, 3569.607343192247, 3574.2486181771005, 4459.375687403766, 4944.936838579687, 5309.230161626542, 5369.382521010095, 5437.755301011464, 3725.608811074825, 4497.730136191839, 4687.671862969593, 4690.132325519756, 4727.101850648366, 5245.659032162897, 5710.486056254916, 5711.257536520267, 5719.113537401709, 5757.88484230313, 3592.784432934006, 3618.8733394331334, 3721.274351501458, 3756.9248615027545, 3906.3554513505237, 4933.407991041098, 5563.638363506359, 5778.3066032076, 5970.761169553212, 6037.30570984338, 3790.5451345838674, 3969.900752481211, 3971.4837071180564, 3973.324534829086, 3998.8000599969887, 3802.9161688918525, 3869.9613003870163, 3926.6073392660505, 3968.8610898618986, 4054.3107671695884, 3870.8838734838, 3939.625735555118, 4661.463931647836, 4696.835610753607, 4738.668293219442, 5861.794837180763, 5866.354700982888, 5879.589837894011, 5895.970520147372, 5917.733701983421, 1161.8605767307808, 1274.5088246751322, 1317.7957416600443, 1354.5800801751489, 1364.6861221919014, 809.6276810805628, 867.2671592504324, 896.8027034052498, 915.2494954137676, 916.9633214671472, 5363.436839131913, 5442.319710036246, 5454.318210223722, 5464.907018596296, 5473.0, 5385.892282154413, 5881.676507792113, 5886.381929897385, 5903.291605007426, 5939.821805345847, 4556.589906908328, 4744.857654270378, 5291.947080529222, 5315.255864179018, 5420.674759514362, 2016.2136766661015, 2327.0226504867996, 2352.6823878776145, 2375.5130198309307, 2631.6052492179174, 4453.421055262795, 4514.932276015862, 5155.432902380735, 5177.223416487482, 5216.713080780593, 4243.380326690373, 4905.9018819624125, 4935.014316338636, 5024.422191447957, 5068.161829375562, 4667.323238130452, 4733.5266473352385, 4783.856484305476, 5093.2105523643895, 5146.897062058738, 4126.649234815074, 4489.775511224491, 5000.449950505369, 5000.499950004971, 5019.824306149413, 4532.9601679243815, 4638.83764068256, 4784.923392236719, 4871.464138944642, 4909.582685471775, 4136.234796562646, 4683.906321873612, 5131.332926719502, 5149.897002059863, 5179.326687530597, 2919.0588258808502, 3216.485362342014, 3308.42849646416, 3429.7256219501883, 3516.4197907346024, 4395.648348132206, 4850.684705494273, 4958.76030992252, 5015.64890457679, 5044.369453818273, 5683.374828768915, 5728.627639203439, 5737.5983681141915, 5738.282714660668, 5749.770009199585, 4829.589484893823, 5742.626729262584, 5771.971140144273, 5774.971125144348, 5838.0, 5442.782288708408, 5555.910464630549, 5628.549716022627, 5688.317401911631, 5712.914306285326, 5184.7926082956255, 5636.070048442125, 5742.397048309867, 5876.294844618502, 5889.793857214977, 5375.758635330521, 5633.267675202197, 5641.802536911188, 5657.32112146545, 5707.9429205709075], "value": 3965.3376947731026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.3513699793228, 675.7297081167529, 717.58738725233, 753.9331845438704, 792.0930534537954, 15018.624534386647, 15381.0, 15823.287952042172, 15862.444814431497, 16148.273327700252, 14343.92828035861, 14610.342534585943, 14631.92684036581, 14648.926755366208, 14674.926625366857, 655.6525041727868, 685.8799710050746, 827.5407149032285, 844.8605980013291, 845.1041895590663, 803.5459965119718, 826.2357319479457, 827.2554700769325, 835.8370117827026, 842.7471758472465, 888.6401007591936, 900.3067637918798, 900.6487469886749, 902.3728508686465, 905.8641203819446, 877.2017464107663, 889.1419779912351, 890.9242714369286, 892.7768057985504, 894.1996912763041, 640.8686219325027, 657.8125234308247, 663.051835874699, 664.2925284571916, 665.2648823050556, 14621.12273263597, 14762.778558321634, 14809.629759255997, 14812.963092583523, 14837.48068817597, 10735.62425315118, 12544.874551254461, 13739.519116830863, 14537.418503259963, 14697.55907322782, 11502.482388292547, 11577.359389422078, 11624.767504649859, 11634.59278925242, 11834.05327573792, 3693.4220869028827, 3754.2303827715527, 3771.0383852117807, 3771.7171212159196, 3783.1677031053123, 109092.90907090907, 109600.0, 111297.44351278192, 111532.4423377886, 113175.0, 9499.477528735848, 11014.669559913216, 11027.889721102847, 11070.889291107147, 11187.888121118847, 22339.329820105424, 22366.66450003251, 22496.550068998527, 22539.98570064351, 22599.548009040056, 7749.225077492319, 7885.566293853778, 7899.131095579482, 7958.403119766041, 8123.18768123183, 4306.720063195945, 4350.0647360817575, 4388.319810429389, 4397.780110994438, 4512.097580483916, 3496.4580490024086, 3577.373959557119, 3654.3056819204267, 3663.0, 3672.5225720656676, 597.9551533634908, 602.5872277489846, 616.1312549305458, 640.0175730254037, 641.7304732012473, 575.6143383932691, 620.7051650465993, 634.622048413443, 637.6206157336377, 639.9712012959428, 8909.866352004725, 9013.752416538793, 9178.632854685738, 9333.766655833522, 9393.295502837314, 559.5970900951309, 620.8944479438507, 640.2509064394576, 644.7775517446568, 645.0904225042667, 3694.3165514379925, 4039.7576145431367, 4103.7742924138865, 4199.811008504625, 4209.873703788891, 166346.1682691603, 167664.0, 169527.0, 173290.0, 174035.0, 136197.0, 136986.0, 140970.0, 142328.0, 144821.0, 114793.53842000243, 119451.80548194407, 120866.79133208732, 122294.0, 123727.0, 7968.163342848918, 7980.281774640311, 7986.520808751494, 8092.878606820785, 8139.715109971123, 48076.27885581789, 62133.689331553054, 64050.35949640444, 65336.0, 67672.0, 99845.00154998357, 100720.0, 102488.0, 102982.0, 105386.0, 10667.413292269, 10702.946485267836, 10739.194560407845, 10809.783804324026, 10820.350778953289, 12762.680932976378, 12783.80824287655, 12816.807747883975, 12862.0, 12961.416736246703, 11705.88294117082, 11885.82171267449, 12060.336681482602, 12072.818907716215, 12328.445219964944, 11914.344711040976, 11931.880681193077, 11959.342236177094, 12080.21478603888, 12479.376031198586, 11598.768024639628, 11612.245204061708, 12089.75820483603, 12171.81742273849, 12311.9384403081, 7842.9607851962655, 8361.581920903809, 9159.86260206084, 10128.797424051625, 10603.045725884707, 6905.413039891465, 8880.51157186361, 9311.44131352121, 10332.431716255678, 10343.224258180517], "value": 7552.9554413201595, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 116.0, 110.0, 106.0, 143.0, 133.0, 152.0, 173.0, 168.0], "value": 132.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 154.0, 141.0, 107.0, 131.0, 110.0, 113.0, 166.0, 105.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 207.0, 219.0, 269.0, 218.0, 199.0, 195.0, 200.0, 202.0, 276.0], "value": 218.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 76.0, 107.0, 89.0, 84.0, 68.0, 62.0, 77.0, 59.0], "value": 76.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 87.0, 74.0, 71.0, 84.0, 73.0, 90.0, 102.0, 72.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 87.0, 91.0, 85.0, 126.0, 133.0, 134.0, 131.0], "value": 105.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 96.0, 95.0, 126.0, 90.0, 137.0, 150.0, 134.0, 94.0], "value": 122.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 91.0, 90.0, 91.0, 91.0, 90.0, 93.0, 90.0, 88.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 57.0, 55.0, 57.0, 57.0, 59.0, 56.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 72.0, 83.0, 77.0, 69.0, 70.0, 90.0, 108.0, 111.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 94.0, 89.0, 101.0, 82.0, 90.0, 87.0, 91.0, 95.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 164.0, 160.0, 164.0, 147.0, 149.0, 169.0, 194.0, 165.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 172.0, 176.0, 174.0, 172.0, 175.0, 173.0, 175.0, 174.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 86.0, 91.0, 93.0, 91.0, 91.0, 63.0, 80.0, 90.0, 89.0], "value": 84.1, "unit": "score"}]}]} 06:35:26 INFO - Return code: 0 06:35:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:26 ERROR - # TBPL SUCCESS # 06:35:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:35:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:35:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:35:26 INFO - 2016-10-12 06:35:26.197 screenresolution[1679:10424] starting screenresolution argv=screenresolution get 06:35:26 INFO - 2016-10-12 06:35:26.200 screenresolution[1679:10424] Display 0: 1600x1200x32@60 06:35:26 INFO - 2016-10-12 06:35:26.207 screenresolution[1680:10427] starting screenresolution argv=screenresolution list 06:35:26 INFO - Available Modes on Display 0 06:35:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:35:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:35:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:35:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:35:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:35:26 INFO - Intel Iris: 06:35:26 INFO - Chipset Model: Intel Iris 06:35:26 INFO - Type: GPU 06:35:26 INFO - Bus: Built-In 06:35:26 INFO - VRAM (Dynamic, Max): 1536 MB 06:35:26 INFO - Vendor: Intel (0x8086) 06:35:26 INFO - Device ID: 0x0a2e 06:35:26 INFO - Revision ID: 0x0009 06:35:26 INFO - Displays: 06:35:26 INFO - Display: 06:35:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:35:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:35:26 INFO - Display Serial Number: 1600x1200 60 06:35:26 INFO - Main Display: Yes 06:35:26 INFO - Mirror: Off 06:35:26 INFO - Online: Yes 06:35:26 INFO - Rotation: Supported 06:35:26 INFO - Return code: 0 06:35:26 INFO - Running post-action listener: _resource_record_post_action 06:35:26 INFO - [mozharness: 2016-10-12 13:35:26.450567Z] Finished run-tests step (success) 06:35:26 INFO - Running post-run listener: _resource_record_post_run 06:35:26 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38688768; Write bytes: 711020032; Read time: 245; Write time: 2062 06:35:26 INFO - TinderboxPrint: CPU usage
54.4% 06:35:26 INFO - TinderboxPrint: I/O read bytes / time
38,688,768 / 245 06:35:26 INFO - TinderboxPrint: I/O write bytes / time
711,020,032 / 2,062 06:35:26 INFO - TinderboxPrint: CPU idle
2,211.9 (45.6%) 06:35:26 INFO - TinderboxPrint: CPU system
979.4 (20.2%) 06:35:26 INFO - TinderboxPrint: CPU user
1,654.5 (34.1%) 06:35:26 INFO - TinderboxPrint: Swap in / out
446,132,224 / 0 06:35:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405858816; Write bytes: 398661120; Read time: 29904; Write time: 847 06:35:26 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36579328; Write bytes: 299395072; Read time: 224; Write time: 1175 06:35:26 INFO - Running post-run listener: _upload_blobber_files 06:35:26 INFO - Blob upload gear active. 06:35:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:35:26 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'] 06:35:26 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 06:35:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:27 INFO - (blobuploader) - INFO - Done attempting. 06:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:29 INFO - (blobuploader) - INFO - Done attempting. 06:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:32 INFO - (blobuploader) - INFO - Done attempting. 06:35:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:32 INFO - Return code: 0 06:35:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55eeea94cb5f75b287a5d4607f77958a99e2161b5eaedd0e98cbaa55cc99fcfc4610a0a220977ecd5c9e9e425c059ca6ca002eebab7260d75870de5f53e77c77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344a3f986a7f5c7e86e36ee83c2204a39cf971269a8163209c221f7304341d0bb992cb2a2c1a28fa4dce312a86fd62158ebbbb50c0f8f9e6966789fcc0787d7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe653897fa3b661d4b84ce36fa268c78a8dd1b4564968d7bc27b8d4093a60b50a5a9ccb8a7ec08a7f5be013bf0fe91e88040ab60d4d1f1e4a0911b33c90fd50b"} 06:35:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:32 INFO - Contents: 06:35:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55eeea94cb5f75b287a5d4607f77958a99e2161b5eaedd0e98cbaa55cc99fcfc4610a0a220977ecd5c9e9e425c059ca6ca002eebab7260d75870de5f53e77c77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344a3f986a7f5c7e86e36ee83c2204a39cf971269a8163209c221f7304341d0bb992cb2a2c1a28fa4dce312a86fd62158ebbbb50c0f8f9e6966789fcc0787d7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe653897fa3b661d4b84ce36fa268c78a8dd1b4564968d7bc27b8d4093a60b50a5a9ccb8a7ec08a7f5be013bf0fe91e88040ab60d4d1f1e4a0911b33c90fd50b"} 06:35:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:32 INFO - Copying logs to upload dir... 06:35:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.006963 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-12 06:35:32.176430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:32.182062) ========= 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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55eeea94cb5f75b287a5d4607f77958a99e2161b5eaedd0e98cbaa55cc99fcfc4610a0a220977ecd5c9e9e425c059ca6ca002eebab7260d75870de5f53e77c77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344a3f986a7f5c7e86e36ee83c2204a39cf971269a8163209c221f7304341d0bb992cb2a2c1a28fa4dce312a86fd62158ebbbb50c0f8f9e6966789fcc0787d7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe653897fa3b661d4b84ce36fa268c78a8dd1b4564968d7bc27b8d4093a60b50a5a9ccb8a7ec08a7f5be013bf0fe91e88040ab60d4d1f1e4a0911b33c90fd50b"} build_url:https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/cmJPfEPzQs608nbMrikpeQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55eeea94cb5f75b287a5d4607f77958a99e2161b5eaedd0e98cbaa55cc99fcfc4610a0a220977ecd5c9e9e425c059ca6ca002eebab7260d75870de5f53e77c77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/344a3f986a7f5c7e86e36ee83c2204a39cf971269a8163209c221f7304341d0bb992cb2a2c1a28fa4dce312a86fd62158ebbbb50c0f8f9e6966789fcc0787d7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe653897fa3b661d4b84ce36fa268c78a8dd1b4564968d7bc27b8d4093a60b50a5a9ccb8a7ec08a7f5be013bf0fe91e88040ab60d4d1f1e4a0911b33c90fd50b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:32.214196) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:32.214539) ========= 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.OvpoyIVEZE/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.AF38ed2ZWF/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.005103 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 06:35:32.263272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:35:32.263598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 06:35:32.263922) ========= ========= Total master_lag: 3.69 =========