builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1476318366.09 results: success (0) buildid: 20161012143919 builduid: 7ff115bc4bed46ab8dff7d359e876ff2 revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.089938) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.090379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.090666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.114569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.114862) ========= 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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:06-- 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% 86.7M=0s 2016-10-12 17:26:06 (86.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.273159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.273467) ========= 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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.032442 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:06.326566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 17:26:06.326880) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22be4ae74653b25186665f22e52a50e7027fd36b --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 22be4ae74653b25186665f22e52a50e7027fd36b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:06,402 truncating revision to first 12 chars 2016-10-12 17:26:06,402 Setting DEBUG logging. 2016-10-12 17:26:06,402 attempt 1/10 2016-10-12 17:26:06,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22be4ae74653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 17:26:07,406 unpacking tar archive at: mozilla-central-22be4ae74653/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 17:26:07.620691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:07.621007) ========= script_repo_revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:07.621437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:07.621732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 17:26:07.639541) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 17:26:07.639858) ========= /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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:07 INFO - MultiFileLogger online at 20161012 17:26:07 in /builds/slave/test 17:26:07 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 17:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:07 INFO - {'append_to_log': False, 17:26:07 INFO - 'base_work_dir': '/builds/slave/test', 17:26:07 INFO - 'blob_upload_branch': 'Firefox', 17:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:07 INFO - 'branch': 'Firefox', 17:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:07 INFO - 'config_files': ('talos/mac_config.py',), 17:26:07 INFO - 'default_actions': ('clobber', 17:26:07 INFO - 'read-buildbot-config', 17:26:07 INFO - 'download-and-extract', 17:26:07 INFO - 'populate-webroot', 17:26:07 INFO - 'create-virtualenv', 17:26:07 INFO - 'install', 17:26:07 INFO - 'run-tests'), 17:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:07 INFO - 'download_minidump_stackwalk': True, 17:26:07 INFO - 'download_symbols': 'ondemand', 17:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:07 INFO - 'installer_path': 'installer.exe', 17:26:07 INFO - 'log_level': 'info', 17:26:07 INFO - 'log_name': 'talos', 17:26:07 INFO - 'log_to_console': True, 17:26:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:26:07 INFO - 'opt_config_files': (), 17:26:07 INFO - 'pip_index': False, 17:26:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:26:07 INFO - 'cmd': ('bash', 17:26:07 INFO - '-c', 17:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:26:07 INFO - 'enabled': True, 17:26:07 INFO - 'halt_on_failure': False, 17:26:07 INFO - 'name': 'check_screen_resolution'},), 17:26:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:26:07 INFO - 'cmd': ('bash', 17:26:07 INFO - '-c', 17:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:26:07 INFO - 'enabled': True, 17:26:07 INFO - 'halt_on_failure': False, 17:26:07 INFO - 'name': 'check_screen_resolution'},), 17:26:07 INFO - 'run_cmd_checks_enabled': True, 17:26:07 INFO - 'sps_profile': False, 17:26:07 INFO - 'sps_profile_interval': 0, 17:26:07 INFO - 'suite': 'dromaeojs-e10s', 17:26:07 INFO - 'system_bits': '32', 17:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:07 INFO - 'title': 't-yosemite-r7-0264', 17:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:07 INFO - 'use_talos_json': True, 17:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:07 INFO - 'work_dir': 'build'} 17:26:07 INFO - [mozharness: 2016-10-13 00:26:07.845856Z] Running clobber step. 17:26:07 INFO - Running pre-action listener: _resource_record_pre_action 17:26:07 INFO - Running main action method: clobber 17:26:07 INFO - rmtree: /builds/slave/test/build 17:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:10 INFO - Running post-action listener: _resource_record_post_action 17:26:10 INFO - [mozharness: 2016-10-13 00:26:10.007655Z] Finished clobber step (success) 17:26:10 INFO - [mozharness: 2016-10-13 00:26:10.007818Z] Running read-buildbot-config step. 17:26:10 INFO - Running pre-action listener: _resource_record_pre_action 17:26:10 INFO - Running main action method: read_buildbot_config 17:26:10 INFO - Using buildbot properties: 17:26:10 INFO - { 17:26:10 INFO - "project": "", 17:26:10 INFO - "product": "firefox", 17:26:10 INFO - "script_repo_revision": "production", 17:26:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:26:10 INFO - "repository": "", 17:26:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:26:10 INFO - "buildid": "20161012143919", 17:26:10 INFO - "stage_platform": "macosx64", 17:26:10 INFO - "basedir": "/builds/slave/test", 17:26:10 INFO - "nightly_build": "True", 17:26:10 INFO - "buildnumber": 3, 17:26:10 INFO - "slavename": "t-yosemite-r7-0264", 17:26:10 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:26:10 INFO - "platform": "yosemite_r7", 17:26:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:26:10 INFO - "branch": "mozilla-central", 17:26:10 INFO - "repo_path": "mozilla-central", 17:26:10 INFO - "revision": "22be4ae74653b25186665f22e52a50e7027fd36b", 17:26:10 INFO - "pgo_build": "False", 17:26:10 INFO - "builduid": "7ff115bc4bed46ab8dff7d359e876ff2", 17:26:10 INFO - "slavebuilddir": "test" 17:26:10 INFO - } 17:26:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:26:10 INFO - Running post-action listener: _resource_record_post_action 17:26:10 INFO - [mozharness: 2016-10-13 00:26:10.011345Z] Finished read-buildbot-config step (success) 17:26:10 INFO - [mozharness: 2016-10-13 00:26:10.011463Z] Running download-and-extract step. 17:26:10 INFO - Running pre-action listener: _resource_record_pre_action 17:26:10 INFO - Running main action method: download_and_extract 17:26:10 INFO - mkdir: /builds/slave/test/build/tests 17:26:10 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')]} 17:26:10 INFO - trying https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:26:10 INFO - Downloading https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/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 17:26:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/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 17:26:11 INFO - Downloaded 1199 bytes. 17:26:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:26:11 INFO - Using the following test package requirements: 17:26:11 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:26:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:26:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:26:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'jsshell-mac.zip'], 17:26:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:26:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:26:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:26:11 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:26:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:26:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:26:11 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:26:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:26:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:26:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:26:11 INFO - Fetch https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:26:12 INFO - Http code: 200 17:26:12 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 17:26:12 INFO - x-amz-cf-id: 2QVU9VFdyLeYH3LPhPoTEe3jA1D4iUDhjOz_xuAOUSgnqEOWjiAAJg== 17:26:12 INFO - x-amz-version-id: 8ysWt9V5aUVVzawC8xxooVXhdWTFrvtL 17:26:12 INFO - Expected file size: 16511213 17:26:12 INFO - Obtained file size: 16511213 17:26:18 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 17:26:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:26:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:26:18 INFO - Fetch https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:26:19 INFO - Http code: 200 17:26:19 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 17:26:19 INFO - x-amz-cf-id: SLsijq5f2MSVsoVIsrIAFkfDco2QIH68USlR6XWNsegNfSbM49ltGQ== 17:26:19 INFO - x-amz-version-id: 8ysWt9V5aUVVzawC8xxooVXhdWTFrvtL 17:26:19 INFO - Expected file size: 16511213 17:26:19 INFO - Obtained file size: 16511213 17:26:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:26:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:26:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:26:27 INFO - Http code: 200 17:26:27 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 17:26:27 INFO - x-amz-cf-id: yUjoPIFmaDwdx2U550f46UahJJTkTeFqA1pRTiQ3f8Bp8g9kqCMOGg== 17:26:27 INFO - x-amz-version-id: .h09bsk7PdoC71g60.1gEt2vZe0B8yV7 17:26:27 INFO - Expected file size: 14409006 17:26:27 INFO - Obtained file size: 14409006 17:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:27 INFO - trying https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:26:27 INFO - Downloading https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/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 17:26:30 INFO - Downloaded 111832073 bytes. 17:26:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:26:30 INFO - mkdir: /builds/slave/test/properties 17:26:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:30 INFO - Contents: 17:26:30 INFO - build_url:https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - Running post-action listener: set_extra_try_arguments 17:26:31 INFO - [mozharness: 2016-10-13 00:26:31.466959Z] Finished download-and-extract step (success) 17:26:31 INFO - [mozharness: 2016-10-13 00:26:31.467091Z] Running populate-webroot step. 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: populate_webroot 17:26:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:31 INFO - '--tppagecycles', 17:26:31 INFO - '7'], 17:26:31 INFO - 'tests': ['tsvgm']}}, 17:26:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['damp', 'tps']}, 17:26:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'tests': ['damp', 'tps']}, 17:26:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['dromaeo_dom']}, 17:26:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['basic_compositor_video']}, 17:26:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:26:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['a11yr', 17:26:31 INFO - 'ts_paint', 17:26:31 INFO - 'tpaint', 17:26:31 INFO - 'sessionrestore', 17:26:31 INFO - 'sessionrestore_no_auto_restore', 17:26:31 INFO - 'tabpaint']}, 17:26:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['tsvgx', 17:26:31 INFO - 'tsvgr_opacity', 17:26:31 INFO - 'tart', 17:26:31 INFO - 'tscrollx', 17:26:31 INFO - 'cart']}, 17:26:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:31 INFO - 'tsvgr_opacity', 17:26:31 INFO - 'tart', 17:26:31 INFO - 'tscrollx', 17:26:31 INFO - 'cart']}, 17:26:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'talos_options': ['--disable-e10s'], 17:26:31 INFO - 'tests': ['tp5o']}, 17:26:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'tests': ['tp5o']}, 17:26:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'talos_options': ['--disable-e10s', 17:26:31 INFO - '--xperf_path', 17:26:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:31 INFO - 'tests': ['tp5n']}, 17:26:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:31 INFO - 'talos_options': ['--xperf_path', 17:26:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:31 INFO - 'tests': ['tp5n']}}, 17:26:31 INFO - 'talos.zip': {'path': '', 17:26:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:31 INFO - Running post-action listener: _resource_record_post_action 17:26:31 INFO - [mozharness: 2016-10-13 00:26:31.485797Z] Finished populate-webroot step (success) 17:26:31 INFO - [mozharness: 2016-10-13 00:26:31.485915Z] Running create-virtualenv step. 17:26:31 INFO - Running pre-action listener: _resource_record_pre_action 17:26:31 INFO - Running main action method: create_virtualenv 17:26:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:31 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 17:26:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:31 INFO - Using real prefix '/tools/python27' 17:26:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:35 INFO - Installing pip.................done. 17:26:35 INFO - Return code: 0 17:26:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:26:35 INFO - Reading from file tmpfile_stdout 17:26:35 INFO - Output received: 17:26:35 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) 17:26:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:35 INFO - 'HOME': '/Users/cltbld', 17:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:35 INFO - 'LOGNAME': 'cltbld', 17:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:35 INFO - 'MOZ_NO_REMOTE': '1', 17:26:35 INFO - 'NO_EM_RESTART': '1', 17:26:35 INFO - 'PAGER': '/bin/cat', 17:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:35 INFO - 'PWD': '/builds/slave/test', 17:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:35 INFO - 'SHELL': '/bin/bash', 17:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:35 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:35 INFO - 'USER': 'cltbld', 17:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:35 INFO - 'XPC_FLAGS': '0x0', 17:26:35 INFO - 'XPC_SERVICE_NAME': '0', 17:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:35 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 17:26:35 INFO - Cleaning up... 17:26:35 INFO - Return code: 0 17:26:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:35 INFO - 'HOME': '/Users/cltbld', 17:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:35 INFO - 'LOGNAME': 'cltbld', 17:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:35 INFO - 'MOZ_NO_REMOTE': '1', 17:26:35 INFO - 'NO_EM_RESTART': '1', 17:26:35 INFO - 'PAGER': '/bin/cat', 17:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:35 INFO - 'PWD': '/builds/slave/test', 17:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:35 INFO - 'SHELL': '/bin/bash', 17:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:35 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:35 INFO - 'USER': 'cltbld', 17:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:35 INFO - 'XPC_FLAGS': '0x0', 17:26:35 INFO - 'XPC_SERVICE_NAME': '0', 17:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:35 INFO - Downloading/unpacking psutil>=3.1.1 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:39 INFO - Installing collected packages: psutil 17:26:39 INFO - Running setup.py install for psutil 17:26:39 INFO - building 'psutil._psutil_osx' extension 17:26:39 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 17:26:40 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 17:26:40 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 17:26:40 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 17:26:40 INFO - building 'psutil._psutil_posix' extension 17:26:40 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 17:26:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:26:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:26:40 INFO - ^ 17:26:40 INFO - 1 warning generated. 17:26:40 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 17:26:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:40 INFO - Successfully installed psutil 17:26:40 INFO - Cleaning up... 17:26:40 INFO - Return code: 0 17:26:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:40 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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:40 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 17:26:40 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 17:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:40 INFO - 'HOME': '/Users/cltbld', 17:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:40 INFO - 'LOGNAME': 'cltbld', 17:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:40 INFO - 'MOZ_NO_REMOTE': '1', 17:26:40 INFO - 'NO_EM_RESTART': '1', 17:26:40 INFO - 'PAGER': '/bin/cat', 17:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:40 INFO - 'PWD': '/builds/slave/test', 17:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:40 INFO - 'SHELL': '/bin/bash', 17:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:40 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:40 INFO - 'USER': 'cltbld', 17:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:40 INFO - 'XPC_FLAGS': '0x0', 17:26:40 INFO - 'XPC_SERVICE_NAME': '0', 17:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:40 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 17:26:40 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 17:26:40 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 17:26:40 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 17:26:40 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 17:26:40 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 17:26:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:43 INFO - Installing collected packages: mozsystemmonitor 17:26:43 INFO - Running setup.py install for mozsystemmonitor 17:26:43 INFO - Successfully installed mozsystemmonitor 17:26:43 INFO - Cleaning up... 17:26:43 INFO - Return code: 0 17:26:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26:43 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')]} 17:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:43 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')]} 17:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:43 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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:43 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 17:26:43 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 17:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:43 INFO - 'HOME': '/Users/cltbld', 17:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:43 INFO - 'LOGNAME': 'cltbld', 17:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:43 INFO - 'MOZ_NO_REMOTE': '1', 17:26:43 INFO - 'NO_EM_RESTART': '1', 17:26:43 INFO - 'PAGER': '/bin/cat', 17:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:43 INFO - 'PWD': '/builds/slave/test', 17:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:43 INFO - 'SHELL': '/bin/bash', 17:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:43 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:43 INFO - 'USER': 'cltbld', 17:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:43 INFO - 'XPC_FLAGS': '0x0', 17:26:43 INFO - 'XPC_SERVICE_NAME': '0', 17:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:44 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:44 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 17:26:44 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 17:26:44 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 17:26:44 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 17:26:44 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 17:26:44 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 17:26:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:46 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 17:26:46 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 17:26:46 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 17:26:46 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 17:26:46 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 17:26:46 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 17:26:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:46 INFO - warning: no files found matching '*.txt' 17:26:46 INFO - no previously-included directories found matching 'build' 17:26:46 INFO - no previously-included directories found matching 'dist' 17:26:46 INFO - no previously-included directories found matching '.git*' 17:26:46 INFO - Installing collected packages: jsonschema, functools32 17:26:47 INFO - Running setup.py install for functools32 17:26:47 INFO - warning: no files found matching '*.txt' 17:26:47 INFO - no previously-included directories found matching 'build' 17:26:47 INFO - no previously-included directories found matching 'dist' 17:26:47 INFO - no previously-included directories found matching '.git*' 17:26:47 INFO - Successfully installed jsonschema functools32 17:26:47 INFO - Cleaning up... 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:47 INFO - 'HOME': '/Users/cltbld', 17:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PAGER': '/bin/cat', 17:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test', 17:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:47 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - 'XPC_FLAGS': '0x0', 17:26:47 INFO - 'XPC_SERVICE_NAME': '0', 17:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:47 INFO - Cleaning up... 17:26:47 INFO - Return code: 0 17:26:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:47 INFO - 'HOME': '/Users/cltbld', 17:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:47 INFO - 'LOGNAME': 'cltbld', 17:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:47 INFO - 'MOZ_NO_REMOTE': '1', 17:26:47 INFO - 'NO_EM_RESTART': '1', 17:26:47 INFO - 'PAGER': '/bin/cat', 17:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:47 INFO - 'PWD': '/builds/slave/test', 17:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:47 INFO - 'SHELL': '/bin/bash', 17:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:47 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:47 INFO - 'USER': 'cltbld', 17:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:47 INFO - 'XPC_FLAGS': '0x0', 17:26:47 INFO - 'XPC_SERVICE_NAME': '0', 17:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:50 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 17:26:50 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 17:26:50 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 17:26:50 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 17:26:50 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 17:26:50 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 17:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:51 INFO - Downloading docopt-0.6.1.tar.gz 17:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:51 INFO - Running setup.py install for blobuploader 17:26:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:51 INFO - Running setup.py install for requests 17:26:52 INFO - Running setup.py install for docopt 17:26:52 INFO - Successfully installed blobuploader requests docopt 17:26:52 INFO - Cleaning up... 17:26:52 INFO - Return code: 0 17:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:52 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')]} 17:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:52 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')]} 17:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:52 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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:52 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 17:26:52 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 17:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:52 INFO - 'HOME': '/Users/cltbld', 17:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:52 INFO - 'LOGNAME': 'cltbld', 17:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:52 INFO - 'MOZ_NO_REMOTE': '1', 17:26:52 INFO - 'NO_EM_RESTART': '1', 17:26:52 INFO - 'PAGER': '/bin/cat', 17:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:52 INFO - 'PWD': '/builds/slave/test', 17:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:52 INFO - 'SHELL': '/bin/bash', 17:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:52 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:52 INFO - 'USER': 'cltbld', 17:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:52 INFO - 'XPC_FLAGS': '0x0', 17:26:52 INFO - 'XPC_SERVICE_NAME': '0', 17:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:52 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-X1X1Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:52 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-6O3T4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:52 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KFqx39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:52 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-J0CjdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TVZKSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-YFq8Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-WeMMZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-w1hHFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-aUu6yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-fwTDOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-osN4PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-gzQeXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-eQmk1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-vvlQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-t7wWDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-iGgtWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-lLEUOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:54 INFO - Running setup.py install for manifestparser 17:26:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:54 INFO - Running setup.py install for mozcrash 17:26:54 INFO - Running setup.py install for mozdebug 17:26:54 INFO - Running setup.py install for mozdevice 17:26:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Running setup.py install for mozfile 17:26:55 INFO - Running setup.py install for mozhttpd 17:26:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Running setup.py install for mozinfo 17:26:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Running setup.py install for mozInstall 17:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Running setup.py install for mozleak 17:26:55 INFO - Running setup.py install for mozlog 17:26:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:55 INFO - Running setup.py install for moznetwork 17:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozprocess 17:26:56 INFO - Running setup.py install for mozprofile 17:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozrunner 17:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:56 INFO - Running setup.py install for mozscreenshot 17:26:56 INFO - Running setup.py install for moztest 17:26:56 INFO - Running setup.py install for mozversion 17:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:57 INFO - Cleaning up... 17:26:57 INFO - Return code: 0 17:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:57 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')]} 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:57 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')]} 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:57 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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:26:57 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 17:26:57 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 17:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:57 INFO - 'HOME': '/Users/cltbld', 17:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:57 INFO - 'LOGNAME': 'cltbld', 17:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:57 INFO - 'MOZ_NO_REMOTE': '1', 17:26:57 INFO - 'NO_EM_RESTART': '1', 17:26:57 INFO - 'PAGER': '/bin/cat', 17:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:57 INFO - 'PWD': '/builds/slave/test', 17:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:57 INFO - 'SHELL': '/bin/bash', 17:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:26:57 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:57 INFO - 'USER': 'cltbld', 17:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:57 INFO - 'XPC_FLAGS': '0x0', 17:26:57 INFO - 'XPC_SERVICE_NAME': '0', 17:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-QI_Dyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-2JMM9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-nAsJ9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-UVfWoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-h86NaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1F6DiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:57 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)) 17:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:57 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-DLRvph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ir9qAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-RUQDpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BPybMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-FuhAKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_rT0ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-XOomiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-qRTfpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-EU6aaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:58 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)) 17:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:58 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ux6iL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:59 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)) 17:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:59 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BcPLTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 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)) 17:26:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:59 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 17:26:59 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 17:26:59 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 17:26:59 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 17:26:59 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 17:26:59 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 17:27:01 INFO - Downloading blessings-1.6.tar.gz 17:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:01 INFO - Installing collected packages: blessings 17:27:01 INFO - Running setup.py install for blessings 17:27:01 INFO - Successfully installed blessings 17:27:01 INFO - Cleaning up... 17:27:02 INFO - Return code: 0 17:27:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:02 INFO - Reading from file tmpfile_stdout 17:27:02 INFO - Current package versions: 17:27:02 INFO - blessings == 1.6 17:27:02 INFO - blobuploader == 1.2.4 17:27:02 INFO - docopt == 0.6.1 17:27:02 INFO - functools32 == 3.2.3-2 17:27:02 INFO - jsonschema == 2.5.1 17:27:02 INFO - manifestparser == 1.1 17:27:02 INFO - mozInstall == 1.12 17:27:02 INFO - mozcrash == 0.17 17:27:02 INFO - mozdebug == 0.1 17:27:02 INFO - mozdevice == 0.48 17:27:02 INFO - mozfile == 1.2 17:27:02 INFO - mozhttpd == 0.7 17:27:02 INFO - mozinfo == 0.9 17:27:02 INFO - mozleak == 0.1 17:27:02 INFO - mozlog == 3.4 17:27:02 INFO - moznetwork == 0.27 17:27:02 INFO - mozprocess == 0.23 17:27:02 INFO - mozprofile == 0.28 17:27:02 INFO - mozrunner == 6.12 17:27:02 INFO - mozscreenshot == 0.1 17:27:02 INFO - mozsystemmonitor == 0.3 17:27:02 INFO - moztest == 0.7 17:27:02 INFO - mozversion == 1.4 17:27:02 INFO - psutil == 3.1.1 17:27:02 INFO - requests == 1.2.3 17:27:02 INFO - wsgiref == 0.1.2 17:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:02 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')]} 17:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:02 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')]} 17:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:02 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 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:27:02 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 17:27:02 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 17:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:27:02 INFO - 'HOME': '/Users/cltbld', 17:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:27:02 INFO - 'LOGNAME': 'cltbld', 17:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:02 INFO - 'MOZ_NO_REMOTE': '1', 17:27:02 INFO - 'NO_EM_RESTART': '1', 17:27:02 INFO - 'PAGER': '/bin/cat', 17:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:02 INFO - 'PWD': '/builds/slave/test', 17:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:27:02 INFO - 'SHELL': '/bin/bash', 17:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:27:02 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:27:02 INFO - 'USER': 'cltbld', 17:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:02 INFO - 'XPC_FLAGS': '0x0', 17:27:02 INFO - 'XPC_SERVICE_NAME': '0', 17:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 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)) 17:27:02 INFO - Cleaning up... 17:27:02 INFO - Return code: 0 17:27:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:02 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')]} 17:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27: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')]} 17:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df5c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ded2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3d2cc6e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, '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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 17:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:27:03 INFO - 'HOME': '/Users/cltbld', 17:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:27:03 INFO - 'LOGNAME': 'cltbld', 17:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:03 INFO - 'MOZ_NO_REMOTE': '1', 17:27:03 INFO - 'NO_EM_RESTART': '1', 17:27:03 INFO - 'PAGER': '/bin/cat', 17:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:03 INFO - 'PWD': '/builds/slave/test', 17:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:27:03 INFO - 'SHELL': '/bin/bash', 17:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:27:03 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:27:03 INFO - 'USER': 'cltbld', 17:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:03 INFO - 'XPC_FLAGS': '0x0', 17:27:03 INFO - 'XPC_SERVICE_NAME': '0', 17:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:03 INFO - Cleaning up... 17:27:03 INFO - Return code: 0 17:27:03 INFO - Running post-action listener: _resource_record_post_action 17:27:03 INFO - Running post-action listener: _start_resource_monitoring 17:27:03 INFO - Starting resource monitoring. 17:27:03 INFO - [mozharness: 2016-10-13 00:27:03.700969Z] Finished create-virtualenv step (success) 17:27:03 INFO - [mozharness: 2016-10-13 00:27:03.701919Z] Running install step. 17:27:03 INFO - Running pre-action listener: _resource_record_pre_action 17:27:03 INFO - Running main action method: install 17:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:03 INFO - Reading from file tmpfile_stdout 17:27:03 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:04 INFO - Reading from file tmpfile_stdout 17:27:04 INFO - Output received: 17:27:04 INFO - Usage: mozinstall [options] installer 17:27:04 INFO - Options: 17:27:04 INFO - -h, --help show this help message and exit 17:27:04 INFO - -d DEST, --destination=DEST 17:27:04 INFO - Directory to install application into. [default: 17:27:04 INFO - "/builds/slave/test"] 17:27:04 INFO - --app=APP Application being installed. [default: firefox] 17:27:04 INFO - mkdir: /builds/slave/test/build/application 17:27:04 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'] 17:27:04 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 17:27:37 INFO - Reading from file tmpfile_stdout 17:27:37 INFO - Output received: 17:27:37 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - [mozharness: 2016-10-13 00:27:37.887848Z] Finished install step (success) 17:27:37 INFO - [mozharness: 2016-10-13 00:27:37.888010Z] Running run-tests step. 17:27:37 INFO - Running pre-action listener: _resource_record_pre_action 17:27:37 INFO - Running main action method: run_tests 17:27:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:27:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:27:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:27:37 INFO - 2016-10-12 17:27:37.902 screenresolution[1640:7453] starting screenresolution argv=screenresolution get 17:27:37 INFO - 2016-10-12 17:27:37.904 screenresolution[1640:7453] Display 0: 1600x1200x32@60 17:27:37 INFO - 2016-10-12 17:27:37.910 screenresolution[1641:7455] starting screenresolution argv=screenresolution list 17:27:37 INFO - Available Modes on Display 0 17:27:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:27:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:27:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:27:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:27:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:27:38 INFO - Intel Iris: 17:27:38 INFO - Chipset Model: Intel Iris 17:27:38 INFO - Type: GPU 17:27:38 INFO - Bus: Built-In 17:27:38 INFO - VRAM (Dynamic, Max): 1536 MB 17:27:38 INFO - Vendor: Intel (0x8086) 17:27:38 INFO - Device ID: 0x0a2e 17:27:38 INFO - Revision ID: 0x0009 17:27:38 INFO - Displays: 17:27:38 INFO - Display: 17:27:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:27:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:27:38 INFO - Display Serial Number: 1600x1200 60 17:27:38 INFO - Main Display: Yes 17:27:38 INFO - Mirror: Off 17:27:38 INFO - Online: Yes 17:27:38 INFO - Rotation: Supported 17:27:38 INFO - Return code: 0 17:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:38 INFO - Python 2.7.3 17:27:38 INFO - Return code: 0 17:27:38 INFO - grabbing minidump binary from tooltool 17:27: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')]} 17:27:38 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 0x10dd70d30>, '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 0x10db96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd68b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:38 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 17:27:38 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 17:27:38 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 17:27:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:38 INFO - Return code: 0 17:27:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:38 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/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 17:27:38 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/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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 17:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GnzFtWXlc0/Render', 17:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:27:38 INFO - 'HOME': '/Users/cltbld', 17:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:27:38 INFO - 'LOGNAME': 'cltbld', 17:27:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:38 INFO - 'MOZ_NO_REMOTE': '1', 17:27:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:38 INFO - 'NO_EM_RESTART': '1', 17:27:38 INFO - 'PAGER': '/bin/cat', 17:27:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:38 INFO - 'PWD': '/builds/slave/test', 17:27:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:27:38 INFO - 'SHELL': '/bin/bash', 17:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C4mb5EeJjI/Listeners', 17:27:38 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 17:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:27:38 INFO - 'USER': 'cltbld', 17:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:38 INFO - 'XPC_FLAGS': '0x0', 17:27:38 INFO - 'XPC_SERVICE_NAME': '0', 17:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:27:38 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/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 17:27:38 INFO - mozversion application_buildid: 20161012143919 17:27:38 INFO - mozversion application_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 17:27:38 INFO - mozversion application_display_name: Nightly 17:27:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:38 INFO - mozversion application_name: Firefox 17:27:38 INFO - mozversion application_remotingname: firefox 17:27:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:27:38 INFO - mozversion application_vendor: Mozilla 17:27:38 INFO - mozversion application_version: 52.0a1 17:27:38 INFO - mozversion platform_buildid: 20161012143919 17:27:38 INFO - mozversion platform_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 17:27:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:27:38 INFO - mozversion platform_version: 52.0a1 17:27:38 INFO - using testdate: 1476318458 17:27:38 INFO - actual date: 1476318458 17:27:38 INFO - starting webserver on 'localhost:49273' 17:27:38 INFO - SUITE-START | Running 2 tests 17:27:38 INFO - TEST-START | dromaeo_css 17:27:38 INFO - operating with platform_type : mac_ 17:27:38 INFO - Initialising browser for dromaeo_css test... 17:27:38 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmplXLxu4/profile http://localhost:49273/getInfo.html) 17:27:41 INFO - PROCESS | 1651 | 2016-10-12 17:27:41.240 plugin-container[1653:7607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 17:27:41 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:27:41 INFO - PROCESS | 1651 | 2016-10-12 17:27:41.240 plugin-container[1653:7607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9223, name = 'com.apple.CFPasteboardClient' 17:27:41 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:27:41 INFO - PROCESS | 1651 | 2016-10-12 17:27:41.240 plugin-container[1653:7607] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:27:41 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:27:41 INFO - PROCESS | 1651 | colorDepth:24 17:27:41 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:27:41 INFO - PROCESS | 1651 | __metrics 17:27:41 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 17:27:42 INFO - TEST-INFO | 1651: exit 0 17:27:42 INFO - Browser initialized. 17:27:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:42 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmplXLxu4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:44 INFO - PROCESS | 1655 | 2016-10-12 17:27:44.405 plugin-container[1656:7743] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 17:27:44 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:27:44 INFO - PROCESS | 1655 | 2016-10-12 17:27:44.405 plugin-container[1656:7743] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 17:27:44 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:27:44 INFO - PROCESS | 1655 | 2016-10-12 17:27:44.405 plugin-container[1656:7743] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:27:54 INFO - PROCESS | 1655 | RSS: Main: 239128576 17:27:54 INFO - PROCESS | 1655 | 17:28:43 INFO - PROCESS | 1655 | 1476318523770 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] 17:30:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:30:58 INFO - PROCESS | 1655 | RSS: Main: 250716160 17:30:58 INFO - PROCESS | 1655 | 17:34:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:34:01 INFO - PROCESS | 1655 | RSS: Main: 267489280 17:34:01 INFO - PROCESS | 1655 | 17:37:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:37:04 INFO - PROCESS | 1655 | RSS: Main: 270647296 17:37:04 INFO - PROCESS | 1655 | 17:40:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:40:06 INFO - PROCESS | 1655 | RSS: Main: 270397440 17:40:06 INFO - PROCESS | 1655 | 17:43:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:43:10 INFO - PROCESS | 1655 | RSS: Main: 275529728 17:43:10 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:46:13 INFO - PROCESS | 1655 | RSS: Main: 278519808 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | __start_tp_report 17:46:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 17:46:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 17:46:13 INFO - PROCESS | 1655 | |i|pagename|runs| 17:46:13 INFO - PROCESS | 1655 | |0;dojo.html;3391.932161356773;3399.810066476732;3410.4884267359894;3416.914577135571;3438.673326034029;4854.951450485494;5667.433256674336;5758.934597099535;5784.219130417403;5797.65214087154;4574.748388838612;5454.59090568207;5601.691906945116;5655.321361436623;5723.9141412878735;5171.767270472819;5257.13257312543;5257.921131183016;5273.446288139748;5304.761285742151;5334.653247538917;5393.056215162351;5398.8920221595545;5414.458554144593;5430.56555475561;5372.54333381661;5376.274202982587;5377.327834020747;5378.327709036371;5388.4611538846;5361.946380536203;5387.488188622075;5390.1914712793005;5393.7303134843105;5397.325334333208;5236.947630523684;5316.521513063843;5328.600354973392;5340.065488539529;5345.65253258537;5745.396733342981;5772.220750198711;5854.385289544579;5925.703714814285;5981.5513836462005;6102.450779429828;6251.093591429263;6285.717142728588;6292.842678933018;6308.653024083674;6106.369660900767;6144.341027922481;6163.414475624853;6221.937780622181;6248.687565621701;5882.088276317135;5889.1755154278435;5901.114832775118;5922.466977972003;5952.315483719384;6375.171227740457;6376.4702359863095;6381.712822922979;6393;6393.328700486382;4907.484714105039;6096.817095487142;6125.081237814364;6252.155958945484;6255.968720156461;6063.120847477091;6133.325334213233;6145.754996538612;6203.6587987660205;6209.037599172136;6260.467860231931;6266.436020758154;6267.435930766253;6277.121203031579;6281.811545653638;6097.4036925702085;6128.717018009172;6221.4089661482085;6263.498920086382;6289.654069026156;4984.7258400788305;5001.299818025479;5010.674306170087;5015.423226329019;5036.899262014739;4472.776361181993;4474.351219073281;4477.082198149372;4493.101379724003;4498.167838949805;5679.403662615448;5711;5777.711114444261;5834.299884013945;5839.795607153729;5087.974560127176;5193.428722840485;5577.749001294951;6244.812655620339;6262.060690896402;5891.05743081105;5927.851803704942;5942.286925568873;5960.821175364659;5978.013627751372;4354;5362.463753624606;5396.676199428047;5411.783528658888;5482.23248745176;6432.935670643234;6434.935650643433;6447.258565265054;6450.870982580416;6456.192975878015;6238.625682459067;6279.717412716347;6296.275928268308;6314.336994615499;6316.684165791784;6180.227471566054;6224.097505861715;6232.937670623236;6277.183966084563;6343.841403964938;6177.382261773966;6235.844103897258;6240.4071613196675;6244.406781355764;6280.152179455715;6142.969285153546;6273.71768270438;6281.309056003927;6281.685915704288;6311.368863113652;5981.7607295707685;6131.601445906002;6132.846678833065;6199.659018754011;6203.565750397429;4826.396700412449;6131.662758548323;6193.4425901669065;6193.6903154841175;6213.2233470816145;5073.670211436245;6016.669083200466;6042.093685947143;6116.480099191441;6143.508519318354;5950.732217050157;6095.634261944298;6186.288576813724;6229.190205273286;6285.59143655661;4809.615230781459;4938.678985865908;6032.939670603238;6092.447387464316;6129.725578588854 17:46:13 INFO - PROCESS | 1655 | |1;ext.html;450.42345797379346;468.56891659673096;477.6632474105755;515.1654320001599;523.4137765702413;32202;39196.608033919685;40934.59065409345;40944.38583421251;40989.79505102474;41973.74078777634;42394.152116957644;42478;42577.36133957985;42582;9577.3295869289;9591.808163836718;9683.418994860296;9803.754906127333;9835.95082024589;9045.954770226173;9565.234781217521;9630.47032413217;9733.270004749673;9747.853782193273;9633.421994680306;9701.854472182922;9722.027797220257;9723.22214222864;9760.804783904317;9681.612735490571;9704.02959704031;9716;9731.610735570568;9756.707298781048;9597.992210817903;9636.988116247834;9683.273754468442;9705.466199359033;9706;40663.18673626541;40923.181536369404;41000;41200;41269.380959285336;3311.9172020699434;3409.62494125646;3493.63316851732;3540.7344449166158;3561.2343346180437;27268.590971135447;29794.85102574495;31398.529022064686;31811.045668629977;31829;3219.0664707234873;3342.29811739535;3423.5207071010077;3427.6572342765526;3428.0058782952915;507911;508279.9999999963;513699.86300136894;513700;520477;32412.189695257806;33198.83400582981;33273.833630832174;35029;52151.73924130355;34318.14204644854;34590.30819383598;34594;34692.826535867156;34812.651873481445;12660.746785064248;14580.562583122522;14588.708225835424;14633.487827926185;14743.63140921464;12329.630111096682;12414.255144691168;12446.25322480654;12460.937695311466;12474.875251247553;7570.507916985378;7620.771376858703;7685.654145563351;7745;7748.806279843049;3059.791382403938;3153.373620336631;3202.6316973547873;3229.5963004624423;3249.9837500812346;759.7530802489213;914.8719179314901;973.255459573427;997.436448406648;1028.187731691955;29416.558751618744;29578.260543486584;30021.549676754865;30035.098947031187;30809;858.5578427110044;984.9261305402124;1036.9429681367446;1067.1676092647747;1118.0775859915602;15535.223238838013;15575.844241557666;15658.686826263638;15705.057696538244;15988.600284992735;601528;633804;640807;643459;648788;56844;57309;57356.71321643365;57602;57629.71185144047;1273.6306471123455;1308.627041293227;1313.914595551286;1334.5262431836752;1340.9731805363838;29617.5557366644;29674.851625741732;29815.403691926473;30256.695762830237;30399.088027359216;49193.2621010678;49268.507314927825;49284;49611.751941241506;49793.00413991772;494021;495837;495978;497350;498058.5097074636;26081.347966300993;26264.60603090917;26522.336941576614;26572;26581.33546661349;46097;46635.76682116568;46746.76626616845;47420;47998;38841;39192.60807392003;39352.803235983636;39731;40357.798211008754;27452.725472745817;37124.62875371212;37437.62562374341;37937.86186414412;38517;24933.376665583506;31308.68691313149;32465.837670811496;37393;38151;31476;33669.32661346808;34526.30947380988;34699.13252168716;34998;22721.204757833395;25399;25829.3542661435;25864.353391165372;26087.217383478524 17:46:13 INFO - PROCESS | 1655 | |2;jquery.html;297.38738199309427;368.6368926607293;369.36284908532775;384.6614978818639;403.9798010099494;18685.626287474242;18970.241190352386;19553.022348882536;20276.087576059093;20491.897540512313;19984.30054948077;20160;20336.593268134628;20355.898220508876;20458.897705511452;5821.767129314822;5835.328937172237;6116.785912493064;6118.265808103034;6144.109104179891;5252.791857872691;5866.237389139406;5905.316984659373;6063.151158837766;6080.300765411968;5760.395158508359;5989.970050149765;6031.758729650809;6047.5766696331275;6048.183495228154;5998.130271110686;6056.939430605682;6063.151158837766;6065;6067.908981365283;5001.774920128603;5204.9219261711105;5222.843314700565;5223.242629818693;5268.947310526884;24571.63142552863;24794.50410991788;24958.875205624037;25338;25589.872050639628;2245.5733410651924;2270.352949409427;2405.6391541268777;2494.239257026606;3040.437519058959;15093.320800564;15112.09327440357;15335.233238338038;15793.763093553605;16167.595810104724;1837.724341348795;1957.4812674641232;1970.6846904495212;1974.2892558678864;1974.5261137327082;108211.91788082097;108341;108565;108948;115268.33179887767;10421.010004049604;10572.31279966815;10824.512896919658;10922.126229901589;11062.170337224741;13475.258860762751;13514.32428378577;13536.59390218295;13537.052406331462;13547.187168769708;6964.547304425196;8129.959350203329;8428;8522;8583.914160858312;7183.85058390655;8207.179282071864;8439.95780021096;8471;8697.086805885418;5431.972840135853;6553.508486863504;6583.967080164664;6614.801555953329;6632.701528431232;1615.6122530592572;1782.1534770983938;1828.2412798688395;1872.410190789897;1874.681304178293;830.7715378271024;887.2148148888151;968.7190714692802;994.5872462927948;1010.2726037253166;21182.94085295729;21998.560028799653;22009.22967696123;22046.88976555139;22267.777322226895;943.4810854030256;962.5379817687409;965.2278177458005;970.0638883477478;1014;8308.418410711312;9305.209057230077;11032.50353734084;11602.245854019462;11809.468573914195;605240;606653.9667301724;617439.9128004331;620942;637816;110784;112555.43722281336;115550;115793.4210328943;119900.8009919907;963.5663951221838;990.5443495991781;998.2662742883974;1011.0092109732503;1013.381837079381;18963.33628323002;19321;19402.2239110434;19429.417117486497;19500.219991200192;37855.43216851805;50307.496925031744;52983;54611.726941365036;54834.90330193454;70517;73507.63246183735;75930;77246;82686.58656706919;5365.3293338332705;6127.29536103336;7628.199039101037;7876.8972343870755;7984.520928744294;9191.586378612845;11350.829737553779;12205.87794122083;12356.196847204903;12450.937745311216;10477.16182705397;10674.412907290174;10846.945765271439;10916;11003.834942476029;7990.520568765893;8903.643854245758;10575.36547807134;10751.838722419014;10917.617883374043;10273.537690803782;10732.570697172026;11078.612248571262;11135.888641113484;11240.55037798479;7760.857978291479;7777.183395743592;8049.51702897828;8076;8239.95880020596;9699.272554558294;10781.676549703521;11110;11131.944340278247;11204.66386008421 17:46:13 INFO - PROCESS | 1655 | |3;mootools.html;1483.6513419346452;1522.2693107308492;1712.3921008042146;1813.0753315808934;1850.1766713812358;7983.682692355769;8277.91722082779;8412.49525028498;8990.460572365662;9022.233110185634;8417.45286556375;8791.95604021979;8805.427647202927;8944.195022447979;8984.2812574994;2303.527776805759;2357.9410514737096;2361.1499860050367;2361.1853910400882;2364.0898254172093;2324.9070037198576;2340.20433052762;2359.752226016269;2370.0993622423457;2371.7865392114704;2340.110757911991;2341.4614638633125;2350.9647355289685;2354;2379.1791831817995;2307.861528308307;2340.2277248507953;2345.5308938212256;2353.446939969106;2353.52929414117;2338.660894170353;2342;2342.273895092527;2345.2260753951155;2345.4019225097663;8945.73162805117;8977.236934860544;8993.460392376479;8999.5050272235;9003.279737620975;5138.511841375063;5269.051570717269;5357.812476563302;5366.2755528004;5372.355317361902;3495.3358861816173;3606.0804494853646;3675.7426980111404;3677.8528858845616;3686.8525258989607;1048.3762161513887;1054.7363159210197;1079.6545105566222;1103.051375816797;1106.9335839849634;10254.69235922916;10765.246432749711;11830.349330786803;11872.40637968098;11886;3586.4261718125495;4137.937930931039;4258.6805989550285;4475.977620111944;4620.630349572026;10022.298439109338;10039.297249192487;10075;10091.949540252252;10099.848502272473;5298.92051619226;5332.706701131475;5339.546138578265;5360.839174824761;5373.811916582979;4365.345198220292;4525.479569849444;4729.503402142795;4876.487968763229;4898.583620392235;3922.9607703922597;3969.4244334571326;4014.397840323975;4063.39049142631;4122.56713045132;1100.273819279272;1255.5731051442372;1267.2903174222465;1275.942582583786;1279.500994612102;801.9238172373615;807.1766797866261;916.9312301577409;939.8308304505118;961.7259081161975;5902.704864756745;6017.638941663514;6033.245844269466;6191.597546159485;6444.742210311629;929.2844509727472;942.2603256443659;952.5999080386255;958.6261358070358;983.9508024598741;3832.6358995895343;3917.9608203917596;4004.5194576650406;4063.817128229237;4147.419361289422;10520.631777887736;10878.456077196266;10908;10914.945425272823;10917.508712107974;10849.511771970281;10864.78270434587;10867.641544806898;10950.34297942126;10972;7761;8091.716789912325;8200.05699344571;8218.137095604876;8220.465669731448;5985.132155837467;6030.095485677183;6098.603590766586;6121.663308517896;6273.592216505913;8495.490270583785;9451.00764419726;9792.657256995972;10064.094231519199;10132.088112069949;9092.227160691415;9390.154886060287;10328.741781455523;10337.9483102584;10402.687919362432;7544.151682837521;7628.771136865903;7629.0845098588525;7720.189380115007;7756.92243077562;8373.665053397795;8390.580470976305;8456.66173353059;8486.74539763808;8496.065432802263;5676.5808547863035;6349.936500634934;6471.7734879279;6908.687349403597;7569.032051666496;6473.190851143607;7406.851862962602;7454.030975973089;7476.850462990601;7548.3961283098315;6465.353464653497;6934.514583979073;7032.156141263081;7032.2264550898335;7035.366816986496;4277.294246449301;5046.722430266371;5064.569511591556;5085.974570127274;5117.385913690381;5049.495050494921;5104.259882317117;5144.742762861767;5195.6622819516615;5211.583073354047 17:46:13 INFO - PROCESS | 1655 | |4;prototype.html;303.60379704485644;303.63715360144636;311.39123014506634;315.8499712636498;317.52054397859223;5281.860846357222;5398.838034858961;5557.332800159951;5583.916241256379;5604.691741954191;4567.949371644524;5149.330587023691;5351.598630102739;5397.975759090341;5408.296921400212;4167.437395951553;4168.95776055986;4169.103058108553;4188.497380314351;4202.2856114460465;3469.4969229461713;3774.8486711552964;4188.183304255671;4198.286291330466;4228.456613336126;4053.493313335833;4074.3684728866924;4084.6323830855217;4085.1829634073156;4091.9386209206887;4080.87757367278;4085.816138273785;4102.630763231324;4107.609777071189;4112.231740351647;3341.766076374655;3495.3358861816173;3521.47177923311;3531.3290474809705;3544.91879976607;5277.47225277473;5282.867928301785;5290.365156181244;5299.735013249322;5345.973270133663;3970.3647416413237;4670.229412146991;4672.15901137795;4702.283666461751;4702.741349225826;4594.379758732562;4727.747147006046;5604.083272570352;5712.11462223356;5731.197632331477;3843.5195600549932;3858.5144719283;3861.687026411034;3885.61143885612;3892.6523190056528;6088.6558674910475;6092.390760923917;6098.35967223444;6135.631862088289;6168.290646575656;3696.464012718141;3913.412988051758;3948.9930067833093;3950.7036972226624;3953.723239373274;4006.8797936061965;4020.9746514639164;4040.878773636796;4050.432939388488;4113.745307681126;3581.6955558777277;4327.307630779123;4729.314249433813;4735.95264047362;4752.049590081998;5371.060064488777;5514.558835293167;5807.8548036299435;5830.533557315404;5908.838771257357;1202.2906485173614;1228.8694401150783;1325.244610571984;1368.4047439363908;1371.348609410542;840.6679361652235;896.8923729152543;897.6902968475865;911.9908800911905;917.9031057885895;4546.954530454653;4720.811167553328;5373.984755716606;5390.92181563681;5405.378381486101;4900.701314151753;5877.2074517271785;5887.4701276884425;5898.734556944948;5939.227900372924;4190.434291370687;5341.145416733381;5345.893082138336;5370.2750128732905;5423;2292.3695983604644;2326.4649130700036;2359.758229681809;2498.25052484254;2527.9747202528106;4739.526047395233;5133.25567792668;5139.897202055938;5168.81909133186;5177;4458.77706114693;4556.70381425213;4966.776495057731;5089.244210747361;6176.907346389808;4852;5549.254253378953;6334.461570766444;6334.904976425358;6358.395952384516;6045.274567051982;6067.453929146398;6068.514518838394;6082.2701275847185;6084.69576521181;5188.377394712658;5288.629795914403;5942.970285148546;5979.4917432018765;6007.7596896125415;5658.434156584309;6284.277308109626;6285.6628926040885;6298.834715577633;6300.464460520907;3442.208292092783;3668.816559172084;3872.9086293401247;3925.862594809168;3967.6230758077936;4537.115262523776;5138.968008874633;5404.86497835459;5905.498032667271;5953.226080609493;4404.498423753188;5145.610685115073;5567.826338986739;5825.50483208915;5924.874273887947;5281.419043905091;5777.595568310178;5792.507636850914;5801.229201019371;5834.824955251349;4003.4195041718203;5568.77724891016;5647.717614119196;5671;5737.569682273763;5069.9746501267255;5345.38528069277;5755.65466072037;5786.855328616818;5812.82561523155;4845.442774081026;5664.660120392625;5674.914876276942;5699.5155411790465;5704.146152500371 17:46:13 INFO - PROCESS | 1655 | |5;yui.html;665.6205962601313;701.3162166887286;703.0263085626409;760.748952845561;796.4424902568201;14983.5504934852;15891.92054039731;15895.761563576556;15902.681946361066;15985.440509582153;12034.09744269179;14311.928440357784;14436.494722684709;14439.42242310309;14440.42238310469;648.1088503307951;687.6527353686406;792.2157064506126;822.4037572759746;840.6469282901196;834.8914641096649;837.8408102460513;838.4759525296689;838.8112674648216;840.0717207485732;867.3061550759398;889.0798024045115;891.5185799668171;893.8614514750192;894.5259012723235;851.6210286422545;879.1560102301798;880.7754022724229;884.8274586455643;885.4112015509743;647.9384458476437;655.5280198257248;658.4337469775988;660.1978596005828;661.8543920337518;14276.14343139415;14674.26628668573;14768.483103091448;14800.851991480054;14833.184174870377;13906.791398129037;14290.356933937997;14359.78460323096;14395.2082635455;14526;11823.467943942544;11834.63901651304;11889.167758256925;11890.821637675443;11942.522299108025;3751.737378383514;3816.160444702161;3830.5977872323283;3943.4873466449467;3962.5244970603426;110121.89878101277;110480.4475977615;111995.88004119936;112981;113050.30424543639;11018.614348497764;11028.724281892857;11034.779304413867;11204.719882003015;11428.914253145938;19401.64188506819;22943.88528057349;23094.42263943415;23107.768922310897;23187.536249275257;6226.782062627877;7545.924540754522;7612.961935190288;7631.656575454118;7809.570473624005;3821.541415030214;4449.17690227309;4462.977685111554;4523.163214805271;4531.229690952546;3418;3557.768745031565;3565.1265439966855;3566.233259849093;3568.0366301098557;651.1469974333638;654.4600704418779;656.4125108028384;661.206552137437;668.8695704337607;497.5646309479206;515.28632843512;612.6599737145926;613.0803794308537;614.3518587889819;8908.73273801787;9130.95434522823;9300.767480812898;9343.672971445967;9448.622055117718;541.6506353402034;572.6077636818792;595.9493443057389;624.2820756130395;626.0796628955428;3750.6061863504483;4226.704130710882;4535.138323718549;4538.341940418621;4578.862634120982;128564.35717821351;153078.23460882626;159783;160607.19696401677;166336;137560;139209.16722078534;139442;140333.28166950712;142462;117621;118814;119700.40149799196;120084.39957800155;120568.39715801364;6644.60132392058;8473.279771219515;8709.968560008567;8780.429272097294;8862.062418179963;67563.66218168878;68578.97131542931;68622.65688671525;69880.30119698738;69972;104051;105001.94998049922;105034;105594;107430;9311.72064838056;10999.450027498753;11323.263987841094;11371.829422558834;11503.53985840557;11936.70158246016;12195.085368597212;12248.510059597873;12263;12486.625401237978;11877.168598198043;11882.16824822254;11903.702407439538;11916.463759130687;11921.225120367148;11809.409529523662;11846.822297665369;11858;11873.643790686294;11894.34581098048;11777.764444711229;11864.703382415508;11876.524939002344;11883.346415947206;11893.226940248856;7110.43116550685;9871.25965552572;9927.652532161339;10094.697159085239;10329.535170917477;9768.609255629979;9981.800363992825;10031;10039.4478303694;10046.547905344423 17:46:13 INFO - PROCESS | 1655 | __end_tp_report 17:46:13 INFO - PROCESS | 1655 | __start_cc_report 17:46:13 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,372 17:46:13 INFO - PROCESS | 1655 | __end_cc_report 17:46:13 INFO - PROCESS | 1655 | __startTimestamp1476319573413__endTimestamp 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | ------- Summary: start ------- 17:46:13 INFO - PROCESS | 1655 | Number of tests: 6 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5741.23 Median:5978.01 stddev:659.27 (11.0%) stddev-sans-first:635.01 17:46:13 INFO - PROCESS | 1655 | Values: 3391.9 3399.8 3410.5 3416.9 3438.7 4855.0 5667.4 5758.9 5784.2 5797.7 4574.7 5454.6 5601.7 5655.3 5723.9 5171.8 5257.1 5257.9 5273.4 5304.8 5334.7 5393.1 5398.9 5414.5 5430.6 5372.5 5376.3 5377.3 5378.3 5388.5 5361.9 5387.5 5390.2 5393.7 5397.3 5236.9 5316.5 5328.6 5340.1 5345.7 5745.4 5772.2 5854.4 5925.7 5981.6 6102.5 6251.1 6285.7 6292.8 6308.7 6106.4 6144.3 6163.4 6221.9 6248.7 5882.1 5889.2 5901.1 5922.5 5952.3 6375.2 6376.5 6381.7 6393.0 6393.3 4907.5 6096.8 6125.1 6252.2 6256.0 6063.1 6133.3 6145.8 6203.7 6209.0 6260.5 6266.4 6267.4 6277.1 6281.8 6097.4 6128.7 6221.4 6263.5 6289.7 4984.7 5001.3 5010.7 5015.4 5036.9 4472.8 4474.4 4477.1 4493.1 4498.2 5679.4 5711.0 5777.7 5834.3 5839.8 5088.0 5193.4 5577.7 6244.8 6262.1 5891.1 5927.9 5942.3 5960.8 5978.0 4354.0 5362.5 5396.7 5411.8 5482.2 6432.9 6434.9 6447.3 6450.9 6456.2 6238.6 6279.7 6296.3 6314.3 6316.7 6180.2 6224.1 6232.9 6277.2 6343.8 6177.4 6235.8 6240.4 6244.4 6280.2 6143.0 6273.7 6281.3 6281.7 6311.4 5981.8 6131.6 6132.8 6199.7 6203.6 4826.4 6131.7 6193.4 6193.7 6213.2 5073.7 6016.7 6042.1 6116.5 6143.5 5950.7 6095.6 6186.3 6229.2 6285.6 4809.6 4938.7 6032.9 6092.4 6129.7 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66293.04 Median:39194.61 stddev:147491.80 (376.3%) stddev-sans-first:147822.71 17:46:13 INFO - PROCESS | 1655 | Values: 450.4 468.6 477.7 515.2 523.4 32202.0 39196.6 40934.6 40944.4 40989.8 41973.7 42394.2 42478.0 42577.4 42582.0 9577.3 9591.8 9683.4 9803.8 9836.0 9046.0 9565.2 9630.5 9733.3 9747.9 9633.4 9701.9 9722.0 9723.2 9760.8 9681.6 9704.0 9716.0 9731.6 9756.7 9598.0 9637.0 9683.3 9705.5 9706.0 40663.2 40923.2 41000.0 41200.0 41269.4 3311.9 3409.6 3493.6 3540.7 3561.2 27268.6 29794.9 31398.5 31811.0 31829.0 3219.1 3342.3 3423.5 3427.7 3428.0 507911.0 508280.0 513699.9 513700.0 520477.0 32412.2 33198.8 33273.8 35029.0 52151.7 34318.1 34590.3 34594.0 34692.8 34812.7 12660.7 14580.6 14588.7 14633.5 14743.6 12329.6 12414.3 12446.3 12460.9 12474.9 7570.5 7620.8 7685.7 7745.0 7748.8 3059.8 3153.4 3202.6 3229.6 3250.0 759.8 914.9 973.3 997.4 1028.2 29416.6 29578.3 30021.5 30035.1 30809.0 858.6 984.9 1036.9 1067.2 1118.1 15535.2 15575.8 15658.7 15705.1 15988.6 601528.0 633804.0 640807.0 643459.0 648788.0 56844.0 57309.0 57356.7 57602.0 57629.7 1273.6 1308.6 1313.9 1334.5 1341.0 29617.6 29674.9 29815.4 30256.7 30399.1 49193.3 49268.5 49284.0 49611.8 49793.0 494021.0 495837.0 495978.0 497350.0 498058.5 26081.3 26264.6 26522.3 26572.0 26581.3 46097.0 46635.8 46746.8 47420.0 47998.0 38841.0 39192.6 39352.8 39731.0 40357.8 27452.7 37124.6 37437.6 37937.9 38517.0 24933.4 31308.7 32465.8 37393.0 38151.0 31476.0 33669.3 34526.3 34699.1 34998.0 22721.2 25399.0 25829.4 25864.4 26087.2 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34856.60 Median:25463.94 stddev:102410.81 (402.2%) stddev-sans-first:102665.22 17:46:13 INFO - PROCESS | 1655 | Values: 297.4 368.6 369.4 384.7 404.0 18685.6 18970.2 19553.0 20276.1 20491.9 19984.3 20160.0 20336.6 20355.9 20458.9 5821.8 5835.3 6116.8 6118.3 6144.1 5252.8 5866.2 5905.3 6063.2 6080.3 5760.4 5990.0 6031.8 6047.6 6048.2 5998.1 6056.9 6063.2 6065.0 6067.9 5001.8 5204.9 5222.8 5223.2 5268.9 24571.6 24794.5 24958.9 25338.0 25589.9 2245.6 2270.4 2405.6 2494.2 3040.4 15093.3 15112.1 15335.2 15793.8 16167.6 1837.7 1957.5 1970.7 1974.3 1974.5 108211.9 108341.0 108565.0 108948.0 115268.3 10421.0 10572.3 10824.5 10922.1 11062.2 13475.3 13514.3 13536.6 13537.1 13547.2 6964.5 8130.0 8428.0 8522.0 8583.9 7183.9 8207.2 8440.0 8471.0 8697.1 5432.0 6553.5 6584.0 6614.8 6632.7 1615.6 1782.2 1828.2 1872.4 1874.7 830.8 887.2 968.7 994.6 1010.3 21182.9 21998.6 22009.2 22046.9 22267.8 943.5 962.5 965.2 970.1 1014.0 8308.4 9305.2 11032.5 11602.2 11809.5 605240.0 606654.0 617439.9 620942.0 637816.0 110784.0 112555.4 115550.0 115793.4 119900.8 963.6 990.5 998.3 1011.0 1013.4 18963.3 19321.0 19402.2 19429.4 19500.2 37855.4 50307.5 52983.0 54611.7 54834.9 70517.0 73507.6 75930.0 77246.0 82686.6 5365.3 6127.3 7628.2 7876.9 7984.5 9191.6 11350.8 12205.9 12356.2 12450.9 10477.2 10674.4 10846.9 10916.0 11003.8 7990.5 8903.6 10575.4 10751.8 10917.6 10273.5 10732.6 11078.6 11135.9 11240.6 7760.9 7777.2 8049.5 8076.0 8240.0 9699.3 10781.7 11110.0 11131.9 11204.7 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5691.95 Median:4972.65 stddev:3186.94 (64.1%) stddev-sans-first:3180.19 17:46:13 INFO - PROCESS | 1655 | Values: 1483.7 1522.3 1712.4 1813.1 1850.2 7983.7 8277.9 8412.5 8990.5 9022.2 8417.5 8792.0 8805.4 8944.2 8984.3 2303.5 2357.9 2361.1 2361.2 2364.1 2324.9 2340.2 2359.8 2370.1 2371.8 2340.1 2341.5 2351.0 2354.0 2379.2 2307.9 2340.2 2345.5 2353.4 2353.5 2338.7 2342.0 2342.3 2345.2 2345.4 8945.7 8977.2 8993.5 8999.5 9003.3 5138.5 5269.1 5357.8 5366.3 5372.4 3495.3 3606.1 3675.7 3677.9 3686.9 1048.4 1054.7 1079.7 1103.1 1106.9 10254.7 10765.2 11830.3 11872.4 11886.0 3586.4 4137.9 4258.7 4476.0 4620.6 10022.3 10039.3 10075.0 10091.9 10099.8 5298.9 5332.7 5339.5 5360.8 5373.8 4365.3 4525.5 4729.5 4876.5 4898.6 3923.0 3969.4 4014.4 4063.4 4122.6 1100.3 1255.6 1267.3 1275.9 1279.5 801.9 807.2 916.9 939.8 961.7 5902.7 6017.6 6033.2 6191.6 6444.7 929.3 942.3 952.6 958.6 984.0 3832.6 3918.0 4004.5 4063.8 4147.4 10520.6 10878.5 10908.0 10914.9 10917.5 10849.5 10864.8 10867.6 10950.3 10972.0 7761.0 8091.7 8200.1 8218.1 8220.5 5985.1 6030.1 6098.6 6121.7 6273.6 8495.5 9451.0 9792.7 10064.1 10132.1 9092.2 9390.2 10328.7 10337.9 10402.7 7544.2 7628.8 7629.1 7720.2 7756.9 8373.7 8390.6 8456.7 8486.7 8496.1 5676.6 6349.9 6471.8 6908.7 7569.0 6473.2 7406.9 7454.0 7476.9 7548.4 6465.4 6934.5 7032.2 7032.2 7035.4 4277.3 5046.7 5064.6 5086.0 5117.4 5049.5 5104.3 5144.7 5195.7 5211.6 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4583.59 Median:5142.75 stddev:1454.16 (28.3%) stddev-sans-first:1422.32 17:46:13 INFO - PROCESS | 1655 | Values: 303.6 303.6 311.4 315.8 317.5 5281.9 5398.8 5557.3 5583.9 5604.7 4567.9 5149.3 5351.6 5398.0 5408.3 4167.4 4169.0 4169.1 4188.5 4202.3 3469.5 3774.8 4188.2 4198.3 4228.5 4053.5 4074.4 4084.6 4085.2 4091.9 4080.9 4085.8 4102.6 4107.6 4112.2 3341.8 3495.3 3521.5 3531.3 3544.9 5277.5 5282.9 5290.4 5299.7 5346.0 3970.4 4670.2 4672.2 4702.3 4702.7 4594.4 4727.7 5604.1 5712.1 5731.2 3843.5 3858.5 3861.7 3885.6 3892.7 6088.7 6092.4 6098.4 6135.6 6168.3 3696.5 3913.4 3949.0 3950.7 3953.7 4006.9 4021.0 4040.9 4050.4 4113.7 3581.7 4327.3 4729.3 4736.0 4752.0 5371.1 5514.6 5807.9 5830.5 5908.8 1202.3 1228.9 1325.2 1368.4 1371.3 840.7 896.9 897.7 912.0 917.9 4547.0 4720.8 5374.0 5390.9 5405.4 4900.7 5877.2 5887.5 5898.7 5939.2 4190.4 5341.1 5345.9 5370.3 5423.0 2292.4 2326.5 2359.8 2498.3 2528.0 4739.5 5133.3 5139.9 5168.8 5177.0 4458.8 4556.7 4966.8 5089.2 6176.9 4852.0 5549.3 6334.5 6334.9 6358.4 6045.3 6067.5 6068.5 6082.3 6084.7 5188.4 5288.6 5943.0 5979.5 6007.8 5658.4 6284.3 6285.7 6298.8 6300.5 3442.2 3668.8 3872.9 3925.9 3967.6 4537.1 5139.0 5404.9 5905.5 5953.2 4404.5 5145.6 5567.8 5825.5 5924.9 5281.4 5777.6 5792.5 5801.2 5834.8 4003.4 5568.8 5647.7 5671.0 5737.6 5070.0 5345.4 5755.7 5786.9 5812.8 4845.4 5664.7 5674.9 5699.5 5704.1 17:46:13 INFO - PROCESS | 1655 | 17:46:13 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25794.82 Median:3561.45 stddev:42535.98 (1194.3%) stddev-sans-first:42613.46 17:46:13 INFO - PROCESS | 1655 | Values: 665.6 701.3 703.0 760.7 796.4 14983.6 15891.9 15895.8 15902.7 15985.4 12034.1 14311.9 14436.5 14439.4 14440.4 648.1 687.7 792.2 822.4 840.6 834.9 837.8 838.5 838.8 840.1 867.3 889.1 891.5 893.9 894.5 851.6 879.2 880.8 884.8 885.4 647.9 655.5 658.4 660.2 661.9 14276.1 14674.3 14768.5 14800.9 14833.2 13906.8 14290.4 14359.8 14395.2 14526.0 11823.5 11834.6 11889.2 11890.8 11942.5 3751.7 3816.2 3830.6 3943.5 3962.5 110121.9 110480.4 111995.9 112981.0 113050.3 11018.6 11028.7 11034.8 11204.7 11428.9 19401.6 22943.9 23094.4 23107.8 23187.5 6226.8 7545.9 7613.0 7631.7 7809.6 3821.5 4449.2 4463.0 4523.2 4531.2 3418.0 3557.8 3565.1 3566.2 3568.0 651.1 654.5 656.4 661.2 668.9 497.6 515.3 612.7 613.1 614.4 8908.7 9131.0 9300.8 9343.7 9448.6 541.7 572.6 595.9 624.3 626.1 3750.6 4226.7 4535.1 4538.3 4578.9 128564.4 153078.2 159783.0 160607.2 166336.0 137560.0 139209.2 139442.0 140333.3 142462.0 117621.0 118814.0 119700.4 120084.4 120568.4 6644.6 8473.3 8710.0 8780.4 8862.1 67563.7 68579.0 68622.7 69880.3 69972.0 104051.0 105001.9 105034.0 105594.0 107430.0 9311.7 10999.5 11323.3 11371.8 11503.5 11936.7 12195.1 12248.5 12263.0 12486.6 11877.2 11882.2 11903.7 11916.5 11921.2 11809.4 11846.8 11858.0 11873.6 11894.3 11777.8 11864.7 11876.5 11883.3 11893.2 7110.4 9871.3 9927.7 10094.7 10329.5 9768.6 9981.8 10031.0 10039.4 10046.5 17:46:13 INFO - PROCESS | 1655 | -------- Summary: end -------- 17:46:13 INFO - PROCESS | 1655 | 17:46:14 INFO - TEST-INFO | 1655: exit 0 17:46:14 INFO - TEST-OK | dromaeo_css | took 1115544ms 17:46:14 INFO - TEST-START | kraken 17:46:14 INFO - operating with platform_type : mac_ 17:46:14 INFO - Initialising browser for kraken test... 17:46:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpjEbCQ1/profile http://localhost:49273/getInfo.html) 17:46:16 INFO - PROCESS | 1667 | 2016-10-12 17:46:16.770 plugin-container[1669:9970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 17:46:16 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:46:16 INFO - PROCESS | 1667 | 2016-10-12 17:46:16.770 plugin-container[1669:9970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.CFPasteboardClient' 17:46:16 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:46:16 INFO - PROCESS | 1667 | 2016-10-12 17:46:16.770 plugin-container[1669:9970] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:46:16 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 17:46:16 INFO - PROCESS | 1667 | colorDepth:24 17:46:16 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 17:46:16 INFO - PROCESS | 1667 | __metrics 17:46:16 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 17:46:17 INFO - TEST-INFO | 1667: exit 0 17:46:17 INFO - Browser initialized. 17:46:17 INFO - Running cycle 1/1 for kraken test... 17:46:17 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpjEbCQ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:20 INFO - PROCESS | 1670 | 2016-10-12 17:46:20.212 plugin-container[1671:10085] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 17:46:20 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:46:20 INFO - PROCESS | 1670 | 2016-10-12 17:46:20.213 plugin-container[1671:10085] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c17, name = 'com.apple.CFPasteboardClient' 17:46:20 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:46:20 INFO - PROCESS | 1670 | 2016-10-12 17:46:20.213 plugin-container[1671:10085] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:46:29 INFO - PROCESS | 1670 | RSS: Main: 239099904 17:46:29 INFO - PROCESS | 1670 | 17:46:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:34 INFO - PROCESS | 1670 | RSS: Main: 252788736 17:46:34 INFO - PROCESS | 1670 | 17:46:36 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:46:37 INFO - PROCESS | 1670 | RSS: Main: 261349376 17:46:37 INFO - PROCESS | 1670 | 17:46:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:46:41 INFO - PROCESS | 1670 | RSS: Main: 261611520 17:46:41 INFO - PROCESS | 1670 | 17:46:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:46:44 INFO - PROCESS | 1670 | RSS: Main: 262279168 17:46:44 INFO - PROCESS | 1670 | 17:46:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:46 INFO - PROCESS | 1670 | RSS: Main: 262508544 17:46:46 INFO - PROCESS | 1670 | 17:46:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:50 INFO - PROCESS | 1670 | RSS: Main: 263127040 17:46:50 INFO - PROCESS | 1670 | 17:46:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:53 INFO - PROCESS | 1670 | RSS: Main: 264609792 17:46:53 INFO - PROCESS | 1670 | 17:46:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:46:57 INFO - PROCESS | 1670 | RSS: Main: 264564736 17:46:57 INFO - PROCESS | 1670 | 17:46:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:59 INFO - PROCESS | 1670 | RSS: Main: 264597504 17:46:59 INFO - PROCESS | 1670 | 17:47:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:47:02 INFO - PROCESS | 1670 | RSS: Main: 264630272 17:47:02 INFO - PROCESS | 1670 | 17:47:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:05 INFO - PROCESS | 1670 | RSS: Main: 264704000 17:47:05 INFO - PROCESS | 1670 | 17:47:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:09 INFO - PROCESS | 1670 | RSS: Main: 265027584 17:47:09 INFO - PROCESS | 1670 | 17:47:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:12 INFO - PROCESS | 1670 | RSS: Main: 264781824 17:47:12 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:47:14 INFO - PROCESS | 1670 | RSS: Main: 266440704 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | __start_tp_report 17:47:14 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 17:47:14 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 17:47:14 INFO - PROCESS | 1670 | |i|pagename|runs| 17:47:14 INFO - PROCESS | 1670 | |0;ai-astar;153;175;135;117;116;121;164;142;174;170 17:47:14 INFO - PROCESS | 1670 | |1;audio-beat-detection;150;144;150;158;154;145;147;123;141;115 17:47:14 INFO - PROCESS | 1670 | |2;audio-dft;273;284;227;197;191;196;192;197;194;198 17:47:14 INFO - PROCESS | 1670 | |3;audio-fft;87;52;66;111;86;81;61;58;78;60 17:47:14 INFO - PROCESS | 1670 | |4;audio-oscillator;88;71;87;70;70;69;88;70;70;90 17:47:14 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;87;90;86;89;86;87;128;89;85 17:47:14 INFO - PROCESS | 1670 | |6;imaging-darkroom;164;172;127;98;100;116;97;97;98;99 17:47:14 INFO - PROCESS | 1670 | |7;imaging-desaturate;91;93;90;92;91;136;149;134;91;83 17:47:14 INFO - PROCESS | 1670 | |8;json-parse-financial;58;55;56;58;58;60;59;58;58;57 17:47:14 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;69;77;88;100;107;107;105;68;72;70 17:47:14 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;91;86;88;89;88;91;88;106;110 17:47:14 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;145;145;178;164;141;161;147;143;196;157 17:47:14 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;172;198;185;173;191;173;177;176;174;171 17:47:14 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;69;70;69;67;70;60;81;93;79 17:47:14 INFO - PROCESS | 1670 | __end_tp_report 17:47:14 INFO - PROCESS | 1670 | __start_cc_report 17:47:14 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,959 17:47:14 INFO - PROCESS | 1670 | __end_cc_report 17:47:14 INFO - PROCESS | 1670 | __startTimestamp1476319634529__endTimestamp 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | ------- Summary: start ------- 17:47:14 INFO - PROCESS | 1670 | Number of tests: 14 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:146.70 Median:158.50 stddev:23.74 (15.0%) stddev-sans-first:25.07 17:47:14 INFO - PROCESS | 1670 | Values: 153.0 175.0 135.0 117.0 116.0 121.0 164.0 142.0 174.0 170.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:148.50 stddev:13.55 (9.1%) stddev-sans-first:14.11 17:47:14 INFO - PROCESS | 1670 | Values: 150.0 144.0 150.0 158.0 154.0 145.0 147.0 123.0 141.0 115.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:214.90 Median:197.50 stddev:35.14 (17.8%) stddev-sans-first:30.34 17:47:14 INFO - PROCESS | 1670 | Values: 273.0 284.0 227.0 197.0 191.0 196.0 192.0 197.0 194.0 198.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:74.00 Median:72.00 stddev:18.00 (25.0%) stddev-sans-first:18.47 17:47:14 INFO - PROCESS | 1670 | Values: 87.0 52.0 66.0 111.0 86.0 81.0 61.0 58.0 78.0 60.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.00 stddev:9.46 (12.0%) stddev-sans-first:9.21 17:47:14 INFO - PROCESS | 1670 | Values: 88.0 71.0 87.0 70.0 70.0 69.0 88.0 70.0 70.0 90.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.00 stddev:12.89 (14.7%) stddev-sans-first:13.64 17:47:14 INFO - PROCESS | 1670 | Values: 89.0 87.0 90.0 86.0 89.0 86.0 87.0 128.0 89.0 85.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:116.80 Median:97.00 stddev:28.81 (29.7%) stddev-sans-first:24.99 17:47:14 INFO - PROCESS | 1670 | Values: 164.0 172.0 127.0 98.0 100.0 116.0 97.0 97.0 98.0 99.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:105.00 Median:91.00 stddev:24.38 (26.8%) stddev-sans-first:25.32 17:47:14 INFO - PROCESS | 1670 | Values: 91.0 93.0 90.0 92.0 91.0 136.0 149.0 134.0 91.0 83.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.42 (2.4%) stddev-sans-first:1.50 17:47:14 INFO - PROCESS | 1670 | Values: 58.0 55.0 56.0 58.0 58.0 60.0 59.0 58.0 58.0 57.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:69.50 stddev:16.96 (24.4%) stddev-sans-first:16.79 17:47:14 INFO - PROCESS | 1670 | Values: 69.0 77.0 88.0 100.0 107.0 107.0 105.0 68.0 72.0 70.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.00 stddev:8.42 (9.6%) stddev-sans-first:8.70 17:47:14 INFO - PROCESS | 1670 | Values: 87.0 91.0 86.0 88.0 89.0 88.0 91.0 88.0 106.0 110.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:157.70 Median:159.00 stddev:17.83 (11.2%) stddev-sans-first:18.31 17:47:14 INFO - PROCESS | 1670 | Values: 145.0 145.0 178.0 164.0 141.0 161.0 147.0 143.0 196.0 157.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:176.50 stddev:9.21 (5.2%) stddev-sans-first:9.42 17:47:14 INFO - PROCESS | 1670 | Values: 172.0 198.0 185.0 173.0 191.0 173.0 177.0 176.0 174.0 171.0 17:47:14 INFO - PROCESS | 1670 | 17:47:14 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:70.00 stddev:9.25 (13.2%) stddev-sans-first:9.71 17:47:14 INFO - PROCESS | 1670 | Values: 69.0 69.0 70.0 69.0 67.0 70.0 60.0 81.0 93.0 79.0 17:47:14 INFO - PROCESS | 1670 | -------- Summary: end -------- 17:47:14 INFO - PROCESS | 1670 | 17:47:15 INFO - TEST-INFO | 1670: exit 0 17:47:15 INFO - TEST-OK | kraken | took 61365ms 17:47:15 INFO - SUITE-END | took 1176s 17:47:15 INFO - Completed test suite (00:19:37) 17:47:15 INFO - javascript benchmark 17:47:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7218.2743774540095, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.932161356773, 3399.810066476732, 3410.4884267359894, 3416.914577135571, 3438.673326034029, 4854.951450485494, 5667.433256674336, 5758.934597099535, 5784.219130417403, 5797.65214087154, 4574.748388838612, 5454.59090568207, 5601.691906945116, 5655.321361436623, 5723.9141412878735, 5171.767270472819, 5257.13257312543, 5257.921131183016, 5273.446288139748, 5304.761285742151, 5334.653247538917, 5393.056215162351, 5398.8920221595545, 5414.458554144593, 5430.56555475561, 5372.54333381661, 5376.274202982587, 5377.327834020747, 5378.327709036371, 5388.4611538846, 5361.946380536203, 5387.488188622075, 5390.1914712793005, 5393.7303134843105, 5397.325334333208, 5236.947630523684, 5316.521513063843, 5328.600354973392, 5340.065488539529, 5345.65253258537, 5745.396733342981, 5772.220750198711, 5854.385289544579, 5925.703714814285, 5981.5513836462005, 6102.450779429828, 6251.093591429263, 6285.717142728588, 6292.842678933018, 6308.653024083674, 6106.369660900767, 6144.341027922481, 6163.414475624853, 6221.937780622181, 6248.687565621701, 5882.088276317135, 5889.1755154278435, 5901.114832775118, 5922.466977972003, 5952.315483719384, 6375.171227740457, 6376.4702359863095, 6381.712822922979, 6393.0, 6393.328700486382, 4907.484714105039, 6096.817095487142, 6125.081237814364, 6252.155958945484, 6255.968720156461, 6063.120847477091, 6133.325334213233, 6145.754996538612, 6203.6587987660205, 6209.037599172136, 6260.467860231931, 6266.436020758154, 6267.435930766253, 6277.121203031579, 6281.811545653638, 6097.4036925702085, 6128.717018009172, 6221.4089661482085, 6263.498920086382, 6289.654069026156, 4984.7258400788305, 5001.299818025479, 5010.674306170087, 5015.423226329019, 5036.899262014739, 4472.776361181993, 4474.351219073281, 4477.082198149372, 4493.101379724003, 4498.167838949805, 5679.403662615448, 5711.0, 5777.711114444261, 5834.299884013945, 5839.795607153729, 5087.974560127176, 5193.428722840485, 5577.749001294951, 6244.812655620339, 6262.060690896402, 5891.05743081105, 5927.851803704942, 5942.286925568873, 5960.821175364659, 5978.013627751372, 4354.0, 5362.463753624606, 5396.676199428047, 5411.783528658888, 5482.23248745176, 6432.935670643234, 6434.935650643433, 6447.258565265054, 6450.870982580416, 6456.192975878015, 6238.625682459067, 6279.717412716347, 6296.275928268308, 6314.336994615499, 6316.684165791784, 6180.227471566054, 6224.097505861715, 6232.937670623236, 6277.183966084563, 6343.841403964938, 6177.382261773966, 6235.844103897258, 6240.4071613196675, 6244.406781355764, 6280.152179455715, 6142.969285153546, 6273.71768270438, 6281.309056003927, 6281.685915704288, 6311.368863113652, 5981.7607295707685, 6131.601445906002, 6132.846678833065, 6199.659018754011, 6203.565750397429, 4826.396700412449, 6131.662758548323, 6193.4425901669065, 6193.6903154841175, 6213.2233470816145, 5073.670211436245, 6016.669083200466, 6042.093685947143, 6116.480099191441, 6143.508519318354, 5950.732217050157, 6095.634261944298, 6186.288576813724, 6229.190205273286, 6285.59143655661, 4809.615230781459, 4938.678985865908, 6032.939670603238, 6092.447387464316, 6129.725578588854], "value": 5702.580109845315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.42345797379346, 468.56891659673096, 477.6632474105755, 515.1654320001599, 523.4137765702413, 32202.0, 39196.608033919685, 40934.59065409345, 40944.38583421251, 40989.79505102474, 41973.74078777634, 42394.152116957644, 42478.0, 42577.36133957985, 42582.0, 9577.3295869289, 9591.808163836718, 9683.418994860296, 9803.754906127333, 9835.95082024589, 9045.954770226173, 9565.234781217521, 9630.47032413217, 9733.270004749673, 9747.853782193273, 9633.421994680306, 9701.854472182922, 9722.027797220257, 9723.22214222864, 9760.804783904317, 9681.612735490571, 9704.02959704031, 9716.0, 9731.610735570568, 9756.707298781048, 9597.992210817903, 9636.988116247834, 9683.273754468442, 9705.466199359033, 9706.0, 40663.18673626541, 40923.181536369404, 41000.0, 41200.0, 41269.380959285336, 3311.9172020699434, 3409.62494125646, 3493.63316851732, 3540.7344449166158, 3561.2343346180437, 27268.590971135447, 29794.85102574495, 31398.529022064686, 31811.045668629977, 31829.0, 3219.0664707234873, 3342.29811739535, 3423.5207071010077, 3427.6572342765526, 3428.0058782952915, 507911.0, 508279.9999999963, 513699.86300136894, 513700.0, 520477.0, 32412.189695257806, 33198.83400582981, 33273.833630832174, 35029.0, 52151.73924130355, 34318.14204644854, 34590.30819383598, 34594.0, 34692.826535867156, 34812.651873481445, 12660.746785064248, 14580.562583122522, 14588.708225835424, 14633.487827926185, 14743.63140921464, 12329.630111096682, 12414.255144691168, 12446.25322480654, 12460.937695311466, 12474.875251247553, 7570.507916985378, 7620.771376858703, 7685.654145563351, 7745.0, 7748.806279843049, 3059.791382403938, 3153.373620336631, 3202.6316973547873, 3229.5963004624423, 3249.9837500812346, 759.7530802489213, 914.8719179314901, 973.255459573427, 997.436448406648, 1028.187731691955, 29416.558751618744, 29578.260543486584, 30021.549676754865, 30035.098947031187, 30809.0, 858.5578427110044, 984.9261305402124, 1036.9429681367446, 1067.1676092647747, 1118.0775859915602, 15535.223238838013, 15575.844241557666, 15658.686826263638, 15705.057696538244, 15988.600284992735, 601528.0, 633804.0, 640807.0, 643459.0, 648788.0, 56844.0, 57309.0, 57356.71321643365, 57602.0, 57629.71185144047, 1273.6306471123455, 1308.627041293227, 1313.914595551286, 1334.5262431836752, 1340.9731805363838, 29617.5557366644, 29674.851625741732, 29815.403691926473, 30256.695762830237, 30399.088027359216, 49193.2621010678, 49268.507314927825, 49284.0, 49611.751941241506, 49793.00413991772, 494021.0, 495837.0, 495978.0, 497350.0, 498058.5097074636, 26081.347966300993, 26264.60603090917, 26522.336941576614, 26572.0, 26581.33546661349, 46097.0, 46635.76682116568, 46746.76626616845, 47420.0, 47998.0, 38841.0, 39192.60807392003, 39352.803235983636, 39731.0, 40357.798211008754, 27452.725472745817, 37124.62875371212, 37437.62562374341, 37937.86186414412, 38517.0, 24933.376665583506, 31308.68691313149, 32465.837670811496, 37393.0, 38151.0, 31476.0, 33669.32661346808, 34526.30947380988, 34699.13252168716, 34998.0, 22721.204757833395, 25399.0, 25829.3542661435, 25864.353391165372, 26087.217383478524], "value": 18168.034002359873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.38738199309427, 368.6368926607293, 369.36284908532775, 384.6614978818639, 403.9798010099494, 18685.626287474242, 18970.241190352386, 19553.022348882536, 20276.087576059093, 20491.897540512313, 19984.30054948077, 20160.0, 20336.593268134628, 20355.898220508876, 20458.897705511452, 5821.767129314822, 5835.328937172237, 6116.785912493064, 6118.265808103034, 6144.109104179891, 5252.791857872691, 5866.237389139406, 5905.316984659373, 6063.151158837766, 6080.300765411968, 5760.395158508359, 5989.970050149765, 6031.758729650809, 6047.5766696331275, 6048.183495228154, 5998.130271110686, 6056.939430605682, 6063.151158837766, 6065.0, 6067.908981365283, 5001.774920128603, 5204.9219261711105, 5222.843314700565, 5223.242629818693, 5268.947310526884, 24571.63142552863, 24794.50410991788, 24958.875205624037, 25338.0, 25589.872050639628, 2245.5733410651924, 2270.352949409427, 2405.6391541268777, 2494.239257026606, 3040.437519058959, 15093.320800564, 15112.09327440357, 15335.233238338038, 15793.763093553605, 16167.595810104724, 1837.724341348795, 1957.4812674641232, 1970.6846904495212, 1974.2892558678864, 1974.5261137327082, 108211.91788082097, 108341.0, 108565.0, 108948.0, 115268.33179887767, 10421.010004049604, 10572.31279966815, 10824.512896919658, 10922.126229901589, 11062.170337224741, 13475.258860762751, 13514.32428378577, 13536.59390218295, 13537.052406331462, 13547.187168769708, 6964.547304425196, 8129.959350203329, 8428.0, 8522.0, 8583.914160858312, 7183.85058390655, 8207.179282071864, 8439.95780021096, 8471.0, 8697.086805885418, 5431.972840135853, 6553.508486863504, 6583.967080164664, 6614.801555953329, 6632.701528431232, 1615.6122530592572, 1782.1534770983938, 1828.2412798688395, 1872.410190789897, 1874.681304178293, 830.7715378271024, 887.2148148888151, 968.7190714692802, 994.5872462927948, 1010.2726037253166, 21182.94085295729, 21998.560028799653, 22009.22967696123, 22046.88976555139, 22267.777322226895, 943.4810854030256, 962.5379817687409, 965.2278177458005, 970.0638883477478, 1014.0, 8308.418410711312, 9305.209057230077, 11032.50353734084, 11602.245854019462, 11809.468573914195, 605240.0, 606653.9667301724, 617439.9128004331, 620942.0, 637816.0, 110784.0, 112555.43722281336, 115550.0, 115793.4210328943, 119900.8009919907, 963.5663951221838, 990.5443495991781, 998.2662742883974, 1011.0092109732503, 1013.381837079381, 18963.33628323002, 19321.0, 19402.2239110434, 19429.417117486497, 19500.219991200192, 37855.43216851805, 50307.496925031744, 52983.0, 54611.726941365036, 54834.90330193454, 70517.0, 73507.63246183735, 75930.0, 77246.0, 82686.58656706919, 5365.3293338332705, 6127.29536103336, 7628.199039101037, 7876.8972343870755, 7984.520928744294, 9191.586378612845, 11350.829737553779, 12205.87794122083, 12356.196847204903, 12450.937745311216, 10477.16182705397, 10674.412907290174, 10846.945765271439, 10916.0, 11003.834942476029, 7990.520568765893, 8903.643854245758, 10575.36547807134, 10751.838722419014, 10917.617883374043, 10273.537690803782, 10732.570697172026, 11078.612248571262, 11135.888641113484, 11240.55037798479, 7760.857978291479, 7777.183395743592, 8049.51702897828, 8076.0, 8239.95880020596, 9699.272554558294, 10781.676549703521, 11110.0, 11131.944340278247, 11204.66386008421], "value": 9547.911759936207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.6513419346452, 1522.2693107308492, 1712.3921008042146, 1813.0753315808934, 1850.1766713812358, 7983.682692355769, 8277.91722082779, 8412.49525028498, 8990.460572365662, 9022.233110185634, 8417.45286556375, 8791.95604021979, 8805.427647202927, 8944.195022447979, 8984.2812574994, 2303.527776805759, 2357.9410514737096, 2361.1499860050367, 2361.1853910400882, 2364.0898254172093, 2324.9070037198576, 2340.20433052762, 2359.752226016269, 2370.0993622423457, 2371.7865392114704, 2340.110757911991, 2341.4614638633125, 2350.9647355289685, 2354.0, 2379.1791831817995, 2307.861528308307, 2340.2277248507953, 2345.5308938212256, 2353.446939969106, 2353.52929414117, 2338.660894170353, 2342.0, 2342.273895092527, 2345.2260753951155, 2345.4019225097663, 8945.73162805117, 8977.236934860544, 8993.460392376479, 8999.5050272235, 9003.279737620975, 5138.511841375063, 5269.051570717269, 5357.812476563302, 5366.2755528004, 5372.355317361902, 3495.3358861816173, 3606.0804494853646, 3675.7426980111404, 3677.8528858845616, 3686.8525258989607, 1048.3762161513887, 1054.7363159210197, 1079.6545105566222, 1103.051375816797, 1106.9335839849634, 10254.69235922916, 10765.246432749711, 11830.349330786803, 11872.40637968098, 11886.0, 3586.4261718125495, 4137.937930931039, 4258.6805989550285, 4475.977620111944, 4620.630349572026, 10022.298439109338, 10039.297249192487, 10075.0, 10091.949540252252, 10099.848502272473, 5298.92051619226, 5332.706701131475, 5339.546138578265, 5360.839174824761, 5373.811916582979, 4365.345198220292, 4525.479569849444, 4729.503402142795, 4876.487968763229, 4898.583620392235, 3922.9607703922597, 3969.4244334571326, 4014.397840323975, 4063.39049142631, 4122.56713045132, 1100.273819279272, 1255.5731051442372, 1267.2903174222465, 1275.942582583786, 1279.500994612102, 801.9238172373615, 807.1766797866261, 916.9312301577409, 939.8308304505118, 961.7259081161975, 5902.704864756745, 6017.638941663514, 6033.245844269466, 6191.597546159485, 6444.742210311629, 929.2844509727472, 942.2603256443659, 952.5999080386255, 958.6261358070358, 983.9508024598741, 3832.6358995895343, 3917.9608203917596, 4004.5194576650406, 4063.817128229237, 4147.419361289422, 10520.631777887736, 10878.456077196266, 10908.0, 10914.945425272823, 10917.508712107974, 10849.511771970281, 10864.78270434587, 10867.641544806898, 10950.34297942126, 10972.0, 7761.0, 8091.716789912325, 8200.05699344571, 8218.137095604876, 8220.465669731448, 5985.132155837467, 6030.095485677183, 6098.603590766586, 6121.663308517896, 6273.592216505913, 8495.490270583785, 9451.00764419726, 9792.657256995972, 10064.094231519199, 10132.088112069949, 9092.227160691415, 9390.154886060287, 10328.741781455523, 10337.9483102584, 10402.687919362432, 7544.151682837521, 7628.771136865903, 7629.0845098588525, 7720.189380115007, 7756.92243077562, 8373.665053397795, 8390.580470976305, 8456.66173353059, 8486.74539763808, 8496.065432802263, 5676.5808547863035, 6349.936500634934, 6471.7734879279, 6908.687349403597, 7569.032051666496, 6473.190851143607, 7406.851862962602, 7454.030975973089, 7476.850462990601, 7548.3961283098315, 6465.353464653497, 6934.514583979073, 7032.156141263081, 7032.2264550898335, 7035.366816986496, 4277.294246449301, 5046.722430266371, 5064.569511591556, 5085.974570127274, 5117.385913690381, 5049.495050494921, 5104.259882317117, 5144.742762861767, 5195.6622819516615, 5211.583073354047], "value": 4579.922498773894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.60379704485644, 303.63715360144636, 311.39123014506634, 315.8499712636498, 317.52054397859223, 5281.860846357222, 5398.838034858961, 5557.332800159951, 5583.916241256379, 5604.691741954191, 4567.949371644524, 5149.330587023691, 5351.598630102739, 5397.975759090341, 5408.296921400212, 4167.437395951553, 4168.95776055986, 4169.103058108553, 4188.497380314351, 4202.2856114460465, 3469.4969229461713, 3774.8486711552964, 4188.183304255671, 4198.286291330466, 4228.456613336126, 4053.493313335833, 4074.3684728866924, 4084.6323830855217, 4085.1829634073156, 4091.9386209206887, 4080.87757367278, 4085.816138273785, 4102.630763231324, 4107.609777071189, 4112.231740351647, 3341.766076374655, 3495.3358861816173, 3521.47177923311, 3531.3290474809705, 3544.91879976607, 5277.47225277473, 5282.867928301785, 5290.365156181244, 5299.735013249322, 5345.973270133663, 3970.3647416413237, 4670.229412146991, 4672.15901137795, 4702.283666461751, 4702.741349225826, 4594.379758732562, 4727.747147006046, 5604.083272570352, 5712.11462223356, 5731.197632331477, 3843.5195600549932, 3858.5144719283, 3861.687026411034, 3885.61143885612, 3892.6523190056528, 6088.6558674910475, 6092.390760923917, 6098.35967223444, 6135.631862088289, 6168.290646575656, 3696.464012718141, 3913.412988051758, 3948.9930067833093, 3950.7036972226624, 3953.723239373274, 4006.8797936061965, 4020.9746514639164, 4040.878773636796, 4050.432939388488, 4113.745307681126, 3581.6955558777277, 4327.307630779123, 4729.314249433813, 4735.95264047362, 4752.049590081998, 5371.060064488777, 5514.558835293167, 5807.8548036299435, 5830.533557315404, 5908.838771257357, 1202.2906485173614, 1228.8694401150783, 1325.244610571984, 1368.4047439363908, 1371.348609410542, 840.6679361652235, 896.8923729152543, 897.6902968475865, 911.9908800911905, 917.9031057885895, 4546.954530454653, 4720.811167553328, 5373.984755716606, 5390.92181563681, 5405.378381486101, 4900.701314151753, 5877.2074517271785, 5887.4701276884425, 5898.734556944948, 5939.227900372924, 4190.434291370687, 5341.145416733381, 5345.893082138336, 5370.2750128732905, 5423.0, 2292.3695983604644, 2326.4649130700036, 2359.758229681809, 2498.25052484254, 2527.9747202528106, 4739.526047395233, 5133.25567792668, 5139.897202055938, 5168.81909133186, 5177.0, 4458.77706114693, 4556.70381425213, 4966.776495057731, 5089.244210747361, 6176.907346389808, 4852.0, 5549.254253378953, 6334.461570766444, 6334.904976425358, 6358.395952384516, 6045.274567051982, 6067.453929146398, 6068.514518838394, 6082.2701275847185, 6084.69576521181, 5188.377394712658, 5288.629795914403, 5942.970285148546, 5979.4917432018765, 6007.7596896125415, 5658.434156584309, 6284.277308109626, 6285.6628926040885, 6298.834715577633, 6300.464460520907, 3442.208292092783, 3668.816559172084, 3872.9086293401247, 3925.862594809168, 3967.6230758077936, 4537.115262523776, 5138.968008874633, 5404.86497835459, 5905.498032667271, 5953.226080609493, 4404.498423753188, 5145.610685115073, 5567.826338986739, 5825.50483208915, 5924.874273887947, 5281.419043905091, 5777.595568310178, 5792.507636850914, 5801.229201019371, 5834.824955251349, 4003.4195041718203, 5568.77724891016, 5647.717614119196, 5671.0, 5737.569682273763, 5069.9746501267255, 5345.38528069277, 5755.65466072037, 5786.855328616818, 5812.82561523155, 4845.442774081026, 5664.660120392625, 5674.914876276942, 5699.5155411790465, 5704.146152500371], "value": 4120.634649107405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.6205962601313, 701.3162166887286, 703.0263085626409, 760.748952845561, 796.4424902568201, 14983.5504934852, 15891.92054039731, 15895.761563576556, 15902.681946361066, 15985.440509582153, 12034.09744269179, 14311.928440357784, 14436.494722684709, 14439.42242310309, 14440.42238310469, 648.1088503307951, 687.6527353686406, 792.2157064506126, 822.4037572759746, 840.6469282901196, 834.8914641096649, 837.8408102460513, 838.4759525296689, 838.8112674648216, 840.0717207485732, 867.3061550759398, 889.0798024045115, 891.5185799668171, 893.8614514750192, 894.5259012723235, 851.6210286422545, 879.1560102301798, 880.7754022724229, 884.8274586455643, 885.4112015509743, 647.9384458476437, 655.5280198257248, 658.4337469775988, 660.1978596005828, 661.8543920337518, 14276.14343139415, 14674.26628668573, 14768.483103091448, 14800.851991480054, 14833.184174870377, 13906.791398129037, 14290.356933937997, 14359.78460323096, 14395.2082635455, 14526.0, 11823.467943942544, 11834.63901651304, 11889.167758256925, 11890.821637675443, 11942.522299108025, 3751.737378383514, 3816.160444702161, 3830.5977872323283, 3943.4873466449467, 3962.5244970603426, 110121.89878101277, 110480.4475977615, 111995.88004119936, 112981.0, 113050.30424543639, 11018.614348497764, 11028.724281892857, 11034.779304413867, 11204.719882003015, 11428.914253145938, 19401.64188506819, 22943.88528057349, 23094.42263943415, 23107.768922310897, 23187.536249275257, 6226.782062627877, 7545.924540754522, 7612.961935190288, 7631.656575454118, 7809.570473624005, 3821.541415030214, 4449.17690227309, 4462.977685111554, 4523.163214805271, 4531.229690952546, 3418.0, 3557.768745031565, 3565.1265439966855, 3566.233259849093, 3568.0366301098557, 651.1469974333638, 654.4600704418779, 656.4125108028384, 661.206552137437, 668.8695704337607, 497.5646309479206, 515.28632843512, 612.6599737145926, 613.0803794308537, 614.3518587889819, 8908.73273801787, 9130.95434522823, 9300.767480812898, 9343.672971445967, 9448.622055117718, 541.6506353402034, 572.6077636818792, 595.9493443057389, 624.2820756130395, 626.0796628955428, 3750.6061863504483, 4226.704130710882, 4535.138323718549, 4538.341940418621, 4578.862634120982, 128564.35717821351, 153078.23460882626, 159783.0, 160607.19696401677, 166336.0, 137560.0, 139209.16722078534, 139442.0, 140333.28166950712, 142462.0, 117621.0, 118814.0, 119700.40149799196, 120084.39957800155, 120568.39715801364, 6644.60132392058, 8473.279771219515, 8709.968560008567, 8780.429272097294, 8862.062418179963, 67563.66218168878, 68578.97131542931, 68622.65688671525, 69880.30119698738, 69972.0, 104051.0, 105001.94998049922, 105034.0, 105594.0, 107430.0, 9311.72064838056, 10999.450027498753, 11323.263987841094, 11371.829422558834, 11503.53985840557, 11936.70158246016, 12195.085368597212, 12248.510059597873, 12263.0, 12486.625401237978, 11877.168598198043, 11882.16824822254, 11903.702407439538, 11916.463759130687, 11921.225120367148, 11809.409529523662, 11846.822297665369, 11858.0, 11873.643790686294, 11894.34581098048, 11777.764444711229, 11864.703382415508, 11876.524939002344, 11883.346415947206, 11893.226940248856, 7110.43116550685, 9871.25965552572, 9927.652532161339, 10094.697159085239, 10329.535170917477, 9768.609255629979, 9981.800363992825, 10031.0, 10039.4478303694, 10046.547905344423], "value": 7576.144820161388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 175.0, 135.0, 117.0, 116.0, 121.0, 164.0, 142.0, 174.0, 170.0], "value": 146.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 144.0, 150.0, 158.0, 154.0, 145.0, 147.0, 123.0, 141.0, 115.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [273.0, 284.0, 227.0, 197.0, 191.0, 196.0, 192.0, 197.0, 194.0, 198.0], "value": 214.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 52.0, 66.0, 111.0, 86.0, 81.0, 61.0, 58.0, 78.0, 60.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 70.0, 70.0, 69.0, 88.0, 70.0, 70.0, 90.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 86.0, 89.0, 86.0, 87.0, 128.0, 89.0, 85.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 127.0, 98.0, 100.0, 116.0, 97.0, 97.0, 98.0, 99.0], "value": 116.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 90.0, 92.0, 91.0, 136.0, 149.0, 134.0, 91.0, 83.0], "value": 105.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 58.0, 58.0, 60.0, 59.0, 58.0, 58.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 88.0, 100.0, 107.0, 107.0, 105.0, 68.0, 72.0, 70.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 86.0, 88.0, 89.0, 88.0, 91.0, 88.0, 106.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 178.0, 164.0, 141.0, 161.0, 147.0, 143.0, 196.0, 157.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 198.0, 185.0, 173.0, 191.0, 173.0, 177.0, 176.0, 174.0, 171.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 69.0, 67.0, 70.0, 60.0, 81.0, 93.0, 79.0], "value": 72.7, "unit": "score"}]}]} 17:47:15 INFO - Return code: 0 17:47:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:47:15 ERROR - # TBPL SUCCESS # 17:47:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:47:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:47:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:47:15 INFO - 2016-10-12 17:47:15.857 screenresolution[1675:10465] starting screenresolution argv=screenresolution get 17:47:15 INFO - 2016-10-12 17:47:15.859 screenresolution[1675:10465] Display 0: 1600x1200x32@60 17:47:15 INFO - 2016-10-12 17:47:15.865 screenresolution[1676:10468] starting screenresolution argv=screenresolution list 17:47:15 INFO - Available Modes on Display 0 17:47:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:47:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:47:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:47:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:47:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:47:16 INFO - Intel Iris: 17:47:16 INFO - Chipset Model: Intel Iris 17:47:16 INFO - Type: GPU 17:47:16 INFO - Bus: Built-In 17:47:16 INFO - VRAM (Dynamic, Max): 1536 MB 17:47:16 INFO - Vendor: Intel (0x8086) 17:47:16 INFO - Device ID: 0x0a2e 17:47:16 INFO - Revision ID: 0x0009 17:47:16 INFO - Displays: 17:47:16 INFO - Display: 17:47:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:47:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:47:16 INFO - Display Serial Number: 1600x1200 60 17:47:16 INFO - Main Display: Yes 17:47:16 INFO - Mirror: Off 17:47:16 INFO - Online: Yes 17:47:16 INFO - Rotation: Supported 17:47:16 INFO - Return code: 0 17:47:16 INFO - Running post-action listener: _resource_record_post_action 17:47:16 INFO - [mozharness: 2016-10-13 00:47:16.101678Z] Finished run-tests step (success) 17:47:16 INFO - Running post-run listener: _resource_record_post_run 17:47:16 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38045696; Write bytes: 711006720; Read time: 244; Write time: 2095 17:47:16 INFO - TinderboxPrint: CPU usage
54.5% 17:47:16 INFO - TinderboxPrint: I/O read bytes / time
38,045,696 / 244 17:47:16 INFO - TinderboxPrint: I/O write bytes / time
711,006,720 / 2,095 17:47:16 INFO - TinderboxPrint: CPU idle
2,203.4 (45.5%) 17:47:16 INFO - TinderboxPrint: CPU system
979.9 (20.2%) 17:47:16 INFO - TinderboxPrint: CPU user
1,662.3 (34.3%) 17:47:16 INFO - TinderboxPrint: Swap in / out
445,517,824 / 0 17:47:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405971456; Write bytes: 400640000; Read time: 29847; Write time: 882 17:47:16 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 35776512; Write bytes: 299430400; Read time: 222; Write time: 1177 17:47:16 INFO - Running post-run listener: _upload_blobber_files 17:47:16 INFO - Blob upload gear active. 17:47:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:16 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 17:47:16 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'] 17:47:16 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 17:47:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:17 INFO - (blobuploader) - INFO - Done attempting. 17:47:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:47:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:18 INFO - (blobuploader) - INFO - Done attempting. 17:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:21 INFO - (blobuploader) - INFO - Done attempting. 17:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:21 INFO - Return code: 0 17:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ab8f704c4ed725729ab861935263aeb4ea06376a60849351040a6196168935c4be46801189ae6b10e94a3d4e80084d49f4780ccefdc5c347e9cd9ddf032423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a7c750936dba6025e3cb316d65224f857f2cb532a5bd48f6ec5c8abc746a3cf650ce2d01f30617598f5240e1aa1f87c5118e137d5d1f378cf2ccf2e5fac6bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd9022d1f21fbfc64e7627e6fd9ec5ec086b71f58cfb3eb2a5f850aad36efc24459ebfe1006a2223093c08ba5378f41830126ee6c3cc306ba0f63fafc9721e7"} 17:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:21 INFO - Contents: 17:47:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ab8f704c4ed725729ab861935263aeb4ea06376a60849351040a6196168935c4be46801189ae6b10e94a3d4e80084d49f4780ccefdc5c347e9cd9ddf032423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a7c750936dba6025e3cb316d65224f857f2cb532a5bd48f6ec5c8abc746a3cf650ce2d01f30617598f5240e1aa1f87c5118e137d5d1f378cf2ccf2e5fac6bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd9022d1f21fbfc64e7627e6fd9ec5ec086b71f58cfb3eb2a5f850aad36efc24459ebfe1006a2223093c08ba5378f41830126ee6c3cc306ba0f63fafc9721e7"} 17:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:21 INFO - Copying logs to upload dir... 17:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.888612 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 17:47:21.669719) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 17:47:21.672937) ========= 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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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/62ab8f704c4ed725729ab861935263aeb4ea06376a60849351040a6196168935c4be46801189ae6b10e94a3d4e80084d49f4780ccefdc5c347e9cd9ddf032423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a7c750936dba6025e3cb316d65224f857f2cb532a5bd48f6ec5c8abc746a3cf650ce2d01f30617598f5240e1aa1f87c5118e137d5d1f378cf2ccf2e5fac6bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd9022d1f21fbfc64e7627e6fd9ec5ec086b71f58cfb3eb2a5f850aad36efc24459ebfe1006a2223093c08ba5378f41830126ee6c3cc306ba0f63fafc9721e7"} build_url:https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/QJzK0NKsRYmn9yJfNq0ccA/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/62ab8f704c4ed725729ab861935263aeb4ea06376a60849351040a6196168935c4be46801189ae6b10e94a3d4e80084d49f4780ccefdc5c347e9cd9ddf032423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a7c750936dba6025e3cb316d65224f857f2cb532a5bd48f6ec5c8abc746a3cf650ce2d01f30617598f5240e1aa1f87c5118e137d5d1f378cf2ccf2e5fac6bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cd9022d1f21fbfc64e7627e6fd9ec5ec086b71f58cfb3eb2a5f850aad36efc24459ebfe1006a2223093c08ba5378f41830126ee6c3cc306ba0f63fafc9721e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 17:47:21.705605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:47:21.705931) ========= 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.GnzFtWXlc0/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.C4mb5EeJjI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005100 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 17:47:21.754538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 17:47:21.754855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 17:47:21.755178) ========= ========= Total master_lag: 0.27 =========