builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1476188100.64 results: success (0) buildid: 20161011030247 builduid: db79f8d2e6df457ba7203ca60d65dced revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.656320) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.656837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.657157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.721643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.721933) ========= 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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-11 05:15:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-10-11 05:15:00 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.918975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.922290) ========= 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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.021046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:00.970429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 05:15:00.970794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-11 05:15:01,045 truncating revision to first 12 chars 2016-10-11 05:15:01,045 Setting DEBUG logging. 2016-10-11 05:15:01,045 attempt 1/10 2016-10-11 05:15:01,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ae377917236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 05:15:02,286 unpacking tar archive at: mozilla-central-7ae377917236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.602369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 05:15:02.597832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:02.601161) ========= script_repo_revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:02.601549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:02.601805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:15:02.619523) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 05:15:02.619850) ========= /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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:02 INFO - MultiFileLogger online at 20161011 05:15:02 in /builds/slave/test 05:15:02 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 05:15:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:02 INFO - {'append_to_log': False, 05:15:02 INFO - 'base_work_dir': '/builds/slave/test', 05:15:02 INFO - 'blob_upload_branch': 'Firefox', 05:15:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:02 INFO - 'branch': 'Firefox', 05:15:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:02 INFO - 'config_files': ('talos/mac_config.py',), 05:15:02 INFO - 'default_actions': ('clobber', 05:15:02 INFO - 'read-buildbot-config', 05:15:02 INFO - 'download-and-extract', 05:15:02 INFO - 'populate-webroot', 05:15:02 INFO - 'create-virtualenv', 05:15:02 INFO - 'install', 05:15:02 INFO - 'run-tests'), 05:15:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:02 INFO - 'download_minidump_stackwalk': True, 05:15:02 INFO - 'download_symbols': 'ondemand', 05:15:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:02 INFO - 'installer_path': 'installer.exe', 05:15:02 INFO - 'log_level': 'info', 05:15:02 INFO - 'log_name': 'talos', 05:15:02 INFO - 'log_to_console': True, 05:15:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:02 INFO - 'opt_config_files': (), 05:15:02 INFO - 'pip_index': False, 05:15:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:02 INFO - 'cmd': ('bash', 05:15:02 INFO - '-c', 05:15:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:02 INFO - 'enabled': True, 05:15:02 INFO - 'halt_on_failure': False, 05:15:02 INFO - 'name': 'check_screen_resolution'},), 05:15:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:02 INFO - 'cmd': ('bash', 05:15:02 INFO - '-c', 05:15:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:02 INFO - 'enabled': True, 05:15:02 INFO - 'halt_on_failure': False, 05:15:02 INFO - 'name': 'check_screen_resolution'},), 05:15:02 INFO - 'run_cmd_checks_enabled': True, 05:15:02 INFO - 'sps_profile': False, 05:15:02 INFO - 'sps_profile_interval': 0, 05:15:02 INFO - 'suite': 'dromaeojs-e10s', 05:15:02 INFO - 'system_bits': '32', 05:15:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:02 INFO - 'title': 't-yosemite-r7-0090', 05:15:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:02 INFO - 'use_talos_json': True, 05:15:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:02 INFO - 'work_dir': 'build'} 05:15:02 INFO - [mozharness: 2016-10-11 12:15:02.820709Z] Running clobber step. 05:15:02 INFO - Running pre-action listener: _resource_record_pre_action 05:15:02 INFO - Running main action method: clobber 05:15:02 INFO - rmtree: /builds/slave/test/build 05:15:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:04 INFO - Running post-action listener: _resource_record_post_action 05:15:04 INFO - [mozharness: 2016-10-11 12:15:04.455417Z] Finished clobber step (success) 05:15:04 INFO - [mozharness: 2016-10-11 12:15:04.455551Z] Running read-buildbot-config step. 05:15:04 INFO - Running pre-action listener: _resource_record_pre_action 05:15:04 INFO - Running main action method: read_buildbot_config 05:15:04 INFO - Using buildbot properties: 05:15:04 INFO - { 05:15:04 INFO - "project": "", 05:15:04 INFO - "product": "firefox", 05:15:04 INFO - "script_repo_revision": "production", 05:15:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:15:04 INFO - "repository": "", 05:15:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:15:04 INFO - "buildid": "20161011030247", 05:15:04 INFO - "pgo_build": "False", 05:15:04 INFO - "basedir": "/builds/slave/test", 05:15:04 INFO - "buildnumber": 135, 05:15:04 INFO - "slavename": "t-yosemite-r7-0090", 05:15:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:15:04 INFO - "platform": "yosemite_r7", 05:15:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:15:04 INFO - "branch": "mozilla-central", 05:15:04 INFO - "repo_path": "mozilla-central", 05:15:04 INFO - "revision": "7ae377917236b7e6111146aa9fb4c073c0efc7f4", 05:15:04 INFO - "stage_platform": "macosx64", 05:15:04 INFO - "builduid": "db79f8d2e6df457ba7203ca60d65dced", 05:15:04 INFO - "slavebuilddir": "test" 05:15:04 INFO - } 05:15:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:15:04 INFO - Running post-action listener: _resource_record_post_action 05:15:04 INFO - [mozharness: 2016-10-11 12:15:04.459773Z] Finished read-buildbot-config step (success) 05:15:04 INFO - [mozharness: 2016-10-11 12:15:04.459930Z] Running download-and-extract step. 05:15:04 INFO - Running pre-action listener: _resource_record_pre_action 05:15:04 INFO - Running main action method: download_and_extract 05:15:04 INFO - mkdir: /builds/slave/test/build/tests 05:15:04 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')]} 05:15:04 INFO - trying https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/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 05:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/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 05:15:05 INFO - Downloaded 1199 bytes. 05:15:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:15:05 INFO - Using the following test package requirements: 05:15:05 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:15:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:15:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'jsshell-mac.zip'], 05:15:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:15:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:15:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:15:05 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:15:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:15:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:15:05 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:15:06 INFO - Http code: 200 05:15:06 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 05:15:06 INFO - x-amz-cf-id: GIOrBNVp65PkVj7huixAf7pIq8-dPNDLtW0PtuLI_ETouLOmomVVqw== 05:15:06 INFO - x-amz-version-id: 8.2DEKuLPaFQ70VARa93ygPhUDFU9BvV 05:15:06 INFO - Expected file size: 16508566 05:15:06 INFO - Obtained file size: 16508566 05:15:13 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 05:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:15:13 INFO - Http code: 200 05:15:13 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 05:15:13 INFO - x-amz-cf-id: y13uvlrMFyKmFI7eMiCvrQU2xCD8vMiQzUqAs6nmzunJJJX-sDWVuw== 05:15:13 INFO - x-amz-version-id: 8.2DEKuLPaFQ70VARa93ygPhUDFU9BvV 05:15:14 INFO - Expected file size: 16508566 05:15:14 INFO - Obtained file size: 16508566 05:15:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:15:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:15:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:15:21 INFO - Http code: 200 05:15:21 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:15:21 INFO - x-amz-cf-id: Om3SSdTtUBGikNg7SjvRdhC-165GB-q0cR_EDw9RlJg1rNJs1FzzkA== 05:15:21 INFO - x-amz-version-id: MY.gztPYTwRSBWRhtiSMFhzUnunoYnL_ 05:15:22 INFO - Expected file size: 14409006 05:15:22 INFO - Obtained file size: 14409006 05:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:22 INFO - trying https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/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 05:15:26 INFO - Downloaded 111700064 bytes. 05:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:15:26 INFO - mkdir: /builds/slave/test/properties 05:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:26 INFO - Contents: 05:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - Running post-action listener: set_extra_try_arguments 05:15:27 INFO - [mozharness: 2016-10-11 12:15:27.473264Z] Finished download-and-extract step (success) 05:15:27 INFO - [mozharness: 2016-10-11 12:15:27.473404Z] Running populate-webroot step. 05:15:27 INFO - Running pre-action listener: _resource_record_pre_action 05:15:27 INFO - Running main action method: populate_webroot 05:15:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:27 INFO - '--tppagecycles', 05:15:27 INFO - '7'], 05:15:27 INFO - 'tests': ['tsvgm']}}, 05:15:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['damp', 'tps']}, 05:15:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'tests': ['damp', 'tps']}, 05:15:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['dromaeo_dom']}, 05:15:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['basic_compositor_video']}, 05:15:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:15:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['a11yr', 05:15:27 INFO - 'ts_paint', 05:15:27 INFO - 'tpaint', 05:15:27 INFO - 'sessionrestore', 05:15:27 INFO - 'sessionrestore_no_auto_restore', 05:15:27 INFO - 'tabpaint']}, 05:15:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['tsvgx', 05:15:27 INFO - 'tsvgr_opacity', 05:15:27 INFO - 'tart', 05:15:27 INFO - 'tscrollx', 05:15:27 INFO - 'cart']}, 05:15:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:27 INFO - 'tsvgr_opacity', 05:15:27 INFO - 'tart', 05:15:27 INFO - 'tscrollx', 05:15:27 INFO - 'cart']}, 05:15:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'talos_options': ['--disable-e10s'], 05:15:27 INFO - 'tests': ['tp5o']}, 05:15:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'tests': ['tp5o']}, 05:15:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'talos_options': ['--disable-e10s', 05:15:27 INFO - '--xperf_path', 05:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:27 INFO - 'tests': ['tp5n']}, 05:15:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:27 INFO - 'talos_options': ['--xperf_path', 05:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:27 INFO - 'tests': ['tp5n']}}, 05:15:27 INFO - 'talos.zip': {'path': '', 05:15:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - [mozharness: 2016-10-11 12:15:27.492156Z] Finished populate-webroot step (success) 05:15:27 INFO - [mozharness: 2016-10-11 12:15:27.492293Z] Running create-virtualenv step. 05:15:27 INFO - Running pre-action listener: _resource_record_pre_action 05:15:27 INFO - Running main action method: create_virtualenv 05:15:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:27 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 05:15:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:27 INFO - Using real prefix '/tools/python27' 05:15:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:31 INFO - Installing pip.................done. 05:15:31 INFO - Return code: 0 05:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:15:31 INFO - Reading from file tmpfile_stdout 05:15:31 INFO - Output received: 05:15:31 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) 05:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:31 INFO - 'HOME': '/Users/cltbld', 05:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:31 INFO - 'LOGNAME': 'cltbld', 05:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:31 INFO - 'MOZ_NO_REMOTE': '1', 05:15:31 INFO - 'NO_EM_RESTART': '1', 05:15:31 INFO - 'PAGER': '/bin/cat', 05:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:31 INFO - 'PWD': '/builds/slave/test', 05:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:31 INFO - 'SHELL': '/bin/bash', 05:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:31 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:31 INFO - 'USER': 'cltbld', 05:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:31 INFO - 'XPC_FLAGS': '0x0', 05:15:31 INFO - 'XPC_SERVICE_NAME': '0', 05:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:31 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 05:15:31 INFO - Cleaning up... 05:15:31 INFO - Return code: 0 05:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:31 INFO - 'HOME': '/Users/cltbld', 05:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:31 INFO - 'LOGNAME': 'cltbld', 05:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:31 INFO - 'MOZ_NO_REMOTE': '1', 05:15:31 INFO - 'NO_EM_RESTART': '1', 05:15:31 INFO - 'PAGER': '/bin/cat', 05:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:31 INFO - 'PWD': '/builds/slave/test', 05:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:31 INFO - 'SHELL': '/bin/bash', 05:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:31 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:31 INFO - 'USER': 'cltbld', 05:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:31 INFO - 'XPC_FLAGS': '0x0', 05:15:31 INFO - 'XPC_SERVICE_NAME': '0', 05:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:32 INFO - Downloading/unpacking psutil>=3.1.1 05:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:36 INFO - Installing collected packages: psutil 05:15:36 INFO - Running setup.py install for psutil 05:15:36 INFO - building 'psutil._psutil_osx' extension 05:15:36 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 05:15:36 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 05:15:36 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 05:15:36 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 05:15:36 INFO - building 'psutil._psutil_posix' extension 05:15:36 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 05:15:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:15:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:15:36 INFO - ^ 05:15:36 INFO - 1 warning generated. 05:15:36 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 05:15:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:36 INFO - Successfully installed psutil 05:15:36 INFO - Cleaning up... 05:15:37 INFO - Return code: 0 05:15:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:37 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')]} 05:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:37 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')]} 05:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:37 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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:37 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 05:15:37 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 05:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:37 INFO - 'HOME': '/Users/cltbld', 05:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:37 INFO - 'LOGNAME': 'cltbld', 05:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:37 INFO - 'MOZ_NO_REMOTE': '1', 05:15:37 INFO - 'NO_EM_RESTART': '1', 05:15:37 INFO - 'PAGER': '/bin/cat', 05:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:37 INFO - 'PWD': '/builds/slave/test', 05:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:37 INFO - 'SHELL': '/bin/bash', 05:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:37 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:37 INFO - 'USER': 'cltbld', 05:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:37 INFO - 'XPC_FLAGS': '0x0', 05:15:37 INFO - 'XPC_SERVICE_NAME': '0', 05:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:37 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 05:15:37 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 05:15:37 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 05:15:37 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 05:15:37 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 05:15:37 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 05:15:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:39 INFO - Installing collected packages: mozsystemmonitor 05:15:39 INFO - Running setup.py install for mozsystemmonitor 05:15:40 INFO - Successfully installed mozsystemmonitor 05:15:40 INFO - Cleaning up... 05:15:40 INFO - Return code: 0 05:15:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:15: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 jsonschema==2.5.1 05:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:40 INFO - 'HOME': '/Users/cltbld', 05:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:40 INFO - 'LOGNAME': 'cltbld', 05:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:40 INFO - 'MOZ_NO_REMOTE': '1', 05:15:40 INFO - 'NO_EM_RESTART': '1', 05:15:40 INFO - 'PAGER': '/bin/cat', 05:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:40 INFO - 'PWD': '/builds/slave/test', 05:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:40 INFO - 'SHELL': '/bin/bash', 05:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:40 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:40 INFO - 'USER': 'cltbld', 05:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:40 INFO - 'XPC_FLAGS': '0x0', 05:15:40 INFO - 'XPC_SERVICE_NAME': '0', 05:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:43 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 05:15:43 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 05:15:43 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 05:15:43 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 05:15:43 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 05:15:43 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 05:15:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:43 INFO - warning: no files found matching '*.txt' 05:15:43 INFO - no previously-included directories found matching 'build' 05:15:43 INFO - no previously-included directories found matching 'dist' 05:15:43 INFO - no previously-included directories found matching '.git*' 05:15:43 INFO - Installing collected packages: jsonschema, functools32 05:15:43 INFO - Running setup.py install for functools32 05:15:43 INFO - warning: no files found matching '*.txt' 05:15:43 INFO - no previously-included directories found matching 'build' 05:15:43 INFO - no previously-included directories found matching 'dist' 05:15:43 INFO - no previously-included directories found matching '.git*' 05:15:43 INFO - Successfully installed jsonschema functools32 05:15:43 INFO - Cleaning up... 05:15:43 INFO - Return code: 0 05:15:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:15: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 functools32==3.2.3-2 05:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:43 INFO - 'HOME': '/Users/cltbld', 05:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:43 INFO - 'LOGNAME': 'cltbld', 05:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:43 INFO - 'MOZ_NO_REMOTE': '1', 05:15:43 INFO - 'NO_EM_RESTART': '1', 05:15:43 INFO - 'PAGER': '/bin/cat', 05:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:43 INFO - 'PWD': '/builds/slave/test', 05:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:43 INFO - 'SHELL': '/bin/bash', 05:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:43 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:43 INFO - 'USER': 'cltbld', 05:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:43 INFO - 'XPC_FLAGS': '0x0', 05:15:43 INFO - 'XPC_SERVICE_NAME': '0', 05:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:15:44 INFO - Cleaning up... 05:15:44 INFO - Return code: 0 05:15:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:44 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')]} 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:44 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')]} 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:44 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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:44 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 05:15:44 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 05:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:44 INFO - 'HOME': '/Users/cltbld', 05:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:44 INFO - 'LOGNAME': 'cltbld', 05:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:44 INFO - 'MOZ_NO_REMOTE': '1', 05:15:44 INFO - 'NO_EM_RESTART': '1', 05:15:44 INFO - 'PAGER': '/bin/cat', 05:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:44 INFO - 'PWD': '/builds/slave/test', 05:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:44 INFO - 'SHELL': '/bin/bash', 05:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:44 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:44 INFO - 'USER': 'cltbld', 05:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:44 INFO - 'XPC_FLAGS': '0x0', 05:15:44 INFO - 'XPC_SERVICE_NAME': '0', 05:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:47 INFO - Downloading docopt-0.6.1.tar.gz 05:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:48 INFO - Running setup.py install for blobuploader 05:15:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:48 INFO - Running setup.py install for requests 05:15:48 INFO - Running setup.py install for docopt 05:15:48 INFO - Successfully installed blobuploader requests docopt 05:15:48 INFO - Cleaning up... 05:15:49 INFO - Return code: 0 05:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:49 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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:49 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 05:15:49 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 05:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:49 INFO - 'HOME': '/Users/cltbld', 05:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:49 INFO - 'LOGNAME': 'cltbld', 05:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:49 INFO - 'MOZ_NO_REMOTE': '1', 05:15:49 INFO - 'NO_EM_RESTART': '1', 05:15:49 INFO - 'PAGER': '/bin/cat', 05:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:49 INFO - 'PWD': '/builds/slave/test', 05:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:49 INFO - 'SHELL': '/bin/bash', 05:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:49 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:49 INFO - 'USER': 'cltbld', 05:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:49 INFO - 'XPC_FLAGS': '0x0', 05:15:49 INFO - 'XPC_SERVICE_NAME': '0', 05:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-govaOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kXCAjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hJIHmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Cwlx_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-FbvtPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-wMikru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rhV8ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-omyDvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7HNEfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-vLeNKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-UmEuRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-m04qwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-B90Mby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-pYi0WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hyyiZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-so0Y2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SCMhGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:51 INFO - Running setup.py install for manifestparser 05:15:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Running setup.py install for mozcrash 05:15:51 INFO - Running setup.py install for mozdebug 05:15:51 INFO - Running setup.py install for mozdevice 05:15:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Running setup.py install for mozfile 05:15:51 INFO - Running setup.py install for mozhttpd 05:15:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Running setup.py install for mozinfo 05:15:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for mozInstall 05:15:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for mozleak 05:15:52 INFO - Running setup.py install for mozlog 05:15:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for moznetwork 05:15:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for mozprocess 05:15:52 INFO - Running setup.py install for mozprofile 05:15:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:52 INFO - Running setup.py install for mozrunner 05:15:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Running setup.py install for mozscreenshot 05:15:53 INFO - Running setup.py install for moztest 05:15:53 INFO - Running setup.py install for mozversion 05:15:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:53 INFO - Cleaning up... 05:15:53 INFO - Return code: 0 05:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:53 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')]} 05:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:53 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')]} 05:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:53 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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:53 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 05:15:53 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 05:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:53 INFO - 'HOME': '/Users/cltbld', 05:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:53 INFO - 'LOGNAME': 'cltbld', 05:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:53 INFO - 'MOZ_NO_REMOTE': '1', 05:15:53 INFO - 'NO_EM_RESTART': '1', 05:15:53 INFO - 'PAGER': '/bin/cat', 05:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:53 INFO - 'PWD': '/builds/slave/test', 05:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:53 INFO - 'SHELL': '/bin/bash', 05:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:53 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:53 INFO - 'USER': 'cltbld', 05:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:53 INFO - 'XPC_FLAGS': '0x0', 05:15:53 INFO - 'XPC_SERVICE_NAME': '0', 05:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:53 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-b5hs2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-F7ewNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-1ud_gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-gcpzSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-r7Gh1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Uz0DvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-EDsfET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-DmQmta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-qTP118-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-pBqiyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:54 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)) 05:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:54 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Mj2jzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-bIvYDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-xyRPZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-TsNVvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0lc3by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-h_3xp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:55 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)) 05:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:55 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-IFEXZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:55 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)) 05:15:55 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)) 05:15:55 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)) 05:15:55 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)) 05:15:55 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)) 05:15:55 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)) 05:15:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:55 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 05:15:58 INFO - Downloading blessings-1.6.tar.gz 05:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:58 INFO - Installing collected packages: blessings 05:15:58 INFO - Running setup.py install for blessings 05:15:58 INFO - Successfully installed blessings 05:15:58 INFO - Cleaning up... 05:15:58 INFO - Return code: 0 05:15:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:58 INFO - Reading from file tmpfile_stdout 05:15:58 INFO - Current package versions: 05:15:58 INFO - blessings == 1.6 05:15:58 INFO - blobuploader == 1.2.4 05:15:58 INFO - docopt == 0.6.1 05:15:58 INFO - functools32 == 3.2.3-2 05:15:58 INFO - jsonschema == 2.5.1 05:15:58 INFO - manifestparser == 1.1 05:15:58 INFO - mozInstall == 1.12 05:15:58 INFO - mozcrash == 0.17 05:15:58 INFO - mozdebug == 0.1 05:15:58 INFO - mozdevice == 0.48 05:15:58 INFO - mozfile == 1.2 05:15:58 INFO - mozhttpd == 0.7 05:15:58 INFO - mozinfo == 0.9 05:15:58 INFO - mozleak == 0.1 05:15:58 INFO - mozlog == 3.4 05:15:58 INFO - moznetwork == 0.27 05:15:58 INFO - mozprocess == 0.23 05:15:58 INFO - mozprofile == 0.28 05:15:58 INFO - mozrunner == 6.12 05:15:58 INFO - mozscreenshot == 0.1 05:15:58 INFO - mozsystemmonitor == 0.3 05:15:58 INFO - moztest == 0.7 05:15:58 INFO - mozversion == 1.4 05:15:58 INFO - psutil == 3.1.1 05:15:58 INFO - requests == 1.2.3 05:15:58 INFO - wsgiref == 0.1.2 05:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:58 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 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:58 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 05:15:58 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 05:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:58 INFO - 'HOME': '/Users/cltbld', 05:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:58 INFO - 'LOGNAME': 'cltbld', 05:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:58 INFO - 'MOZ_NO_REMOTE': '1', 05:15:58 INFO - 'NO_EM_RESTART': '1', 05:15:58 INFO - 'PAGER': '/bin/cat', 05:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:58 INFO - 'PWD': '/builds/slave/test', 05:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:58 INFO - 'SHELL': '/bin/bash', 05:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:58 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:58 INFO - 'USER': 'cltbld', 05:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:58 INFO - 'XPC_FLAGS': '0x0', 05:15:58 INFO - 'XPC_SERVICE_NAME': '0', 05:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 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)) 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10904a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c81cd9e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, '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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 05:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:59 INFO - 'HOME': '/Users/cltbld', 05:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:59 INFO - 'LOGNAME': 'cltbld', 05:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:59 INFO - 'MOZ_NO_REMOTE': '1', 05:15:59 INFO - 'NO_EM_RESTART': '1', 05:15:59 INFO - 'PAGER': '/bin/cat', 05:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:59 INFO - 'PWD': '/builds/slave/test', 05:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:59 INFO - 'SHELL': '/bin/bash', 05:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:15:59 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:59 INFO - 'USER': 'cltbld', 05:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:59 INFO - 'XPC_FLAGS': '0x0', 05:15:59 INFO - 'XPC_SERVICE_NAME': '0', 05:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:59 INFO - Cleaning up... 05:15:59 INFO - Return code: 0 05:15:59 INFO - Running post-action listener: _resource_record_post_action 05:15:59 INFO - Running post-action listener: _start_resource_monitoring 05:15:59 INFO - Starting resource monitoring. 05:15:59 INFO - [mozharness: 2016-10-11 12:15:59.447166Z] Finished create-virtualenv step (success) 05:15:59 INFO - [mozharness: 2016-10-11 12:15:59.448163Z] Running install step. 05:15:59 INFO - Running pre-action listener: _resource_record_pre_action 05:15:59 INFO - Running main action method: install 05:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:59 INFO - Reading from file tmpfile_stdout 05:15:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:59 INFO - Reading from file tmpfile_stdout 05:15:59 INFO - Output received: 05:15:59 INFO - Usage: mozinstall [options] installer 05:15:59 INFO - Options: 05:15:59 INFO - -h, --help show this help message and exit 05:15:59 INFO - -d DEST, --destination=DEST 05:15:59 INFO - Directory to install application into. [default: 05:15:59 INFO - "/builds/slave/test"] 05:15:59 INFO - --app=APP Application being installed. [default: firefox] 05:15:59 INFO - mkdir: /builds/slave/test/build/application 05:15:59 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'] 05:15:59 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 05:16:33 INFO - Reading from file tmpfile_stdout 05:16:33 INFO - Output received: 05:16:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:16:33 INFO - Running post-action listener: _resource_record_post_action 05:16:33 INFO - [mozharness: 2016-10-11 12:16:33.914963Z] Finished install step (success) 05:16:33 INFO - [mozharness: 2016-10-11 12:16:33.915089Z] Running run-tests step. 05:16:33 INFO - Running pre-action listener: _resource_record_pre_action 05:16:33 INFO - Running main action method: run_tests 05:16:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:33 INFO - 2016-10-11 05:16:33.930 screenresolution[1942:16045] starting screenresolution argv=screenresolution get 05:16:33 INFO - 2016-10-11 05:16:33.932 screenresolution[1942:16045] Display 0: 1600x1200x32@60 05:16:33 INFO - 2016-10-11 05:16:33.938 screenresolution[1943:16047] starting screenresolution argv=screenresolution list 05:16:33 INFO - Available Modes on Display 0 05:16:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:34 INFO - Intel Iris: 05:16:34 INFO - Chipset Model: Intel Iris 05:16:34 INFO - Type: GPU 05:16:34 INFO - Bus: Built-In 05:16:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:34 INFO - Vendor: Intel (0x8086) 05:16:34 INFO - Device ID: 0x0a2e 05:16:34 INFO - Revision ID: 0x0009 05:16:34 INFO - Displays: 05:16:34 INFO - Display: 05:16:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:34 INFO - Display Serial Number: 1600x1200 60 05:16:34 INFO - Main Display: Yes 05:16:34 INFO - Mirror: Off 05:16:34 INFO - Online: Yes 05:16:34 INFO - Rotation: Supported 05:16:34 INFO - Return code: 0 05:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:34 INFO - Python 2.7.3 05:16:34 INFO - Return code: 0 05:16:34 INFO - grabbing minidump binary from tooltool 05:16:34 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')]} 05:16:34 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 0x108ee8d30>, '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 0x108d0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ee0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:34 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 05:16:34 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 05:16:34 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 05:16:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:34 INFO - Return code: 0 05:16:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:16:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:16:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 05:16:34 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 05:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rhUt7S1emQ/Render', 05:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:34 INFO - 'HOME': '/Users/cltbld', 05:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:34 INFO - 'LOGNAME': 'cltbld', 05:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:34 INFO - 'MOZ_NO_REMOTE': '1', 05:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:34 INFO - 'NO_EM_RESTART': '1', 05:16:34 INFO - 'PAGER': '/bin/cat', 05:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:34 INFO - 'PWD': '/builds/slave/test', 05:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:34 INFO - 'SHELL': '/bin/bash', 05:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvVs9WG7kS/Listeners', 05:16:34 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 05:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:34 INFO - 'USER': 'cltbld', 05:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:34 INFO - 'XPC_FLAGS': '0x0', 05:16:34 INFO - 'XPC_SERVICE_NAME': '0', 05:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 05:16:34 INFO - mozversion application_buildid: 20161011030247 05:16:34 INFO - mozversion application_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 05:16:34 INFO - mozversion application_display_name: Nightly 05:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:34 INFO - mozversion application_name: Firefox 05:16:34 INFO - mozversion application_remotingname: firefox 05:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:34 INFO - mozversion application_vendor: Mozilla 05:16:34 INFO - mozversion application_version: 52.0a1 05:16:34 INFO - mozversion platform_buildid: 20161011030247 05:16:34 INFO - mozversion platform_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 05:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:34 INFO - mozversion platform_version: 52.0a1 05:16:34 INFO - using testdate: 1476188194 05:16:34 INFO - actual date: 1476188194 05:16:34 INFO - starting webserver on 'localhost:52334' 05:16:34 INFO - SUITE-START | Running 2 tests 05:16:34 INFO - TEST-START | dromaeo_css 05:16:34 INFO - operating with platform_type : mac_ 05:16:34 INFO - Initialising browser for dromaeo_css test... 05:16:34 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpSm_lSu/profile http://localhost:52334/getInfo.html) 05:16:37 INFO - PROCESS | 1953 | 2016-10-11 05:16:37.276 plugin-container[1955:16213] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 05:16:37 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:37 INFO - PROCESS | 1953 | 2016-10-11 05:16:37.280 plugin-container[1955:16213] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 05:16:37 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:37 INFO - PROCESS | 1953 | 2016-10-11 05:16:37.281 plugin-container[1955:16213] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:16:37 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 05:16:37 INFO - PROCESS | 1953 | colorDepth:24 05:16:37 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 05:16:37 INFO - PROCESS | 1953 | __metrics 05:16:37 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 05:16:38 INFO - TEST-INFO | 1953: exit 0 05:16:38 INFO - Browser initialized. 05:16:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:38 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpSm_lSu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:40 INFO - PROCESS | 1956 | 2016-10-11 05:16:40.439 plugin-container[1957:16338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 05:16:40 INFO - PROCESS | 1956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:40 INFO - PROCESS | 1956 | 2016-10-11 05:16:40.440 plugin-container[1957:16338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 05:16:40 INFO - PROCESS | 1956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:40 INFO - PROCESS | 1956 | 2016-10-11 05:16:40.440 plugin-container[1957:16338] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:16:50 INFO - PROCESS | 1956 | RSS: Main: 238661632 05:16:50 INFO - PROCESS | 1956 | 05:17:39 INFO - PROCESS | 1956 | 1476188259799 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] 05:19:52 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52334/tests/dromaeo/cssquery-ext.html) 05:19:54 INFO - PROCESS | 1956 | RSS: Main: 252485632 05:19:54 INFO - PROCESS | 1956 | 05:22:57 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-ext.html (next: http://localhost:52334/tests/dromaeo/cssquery-jquery.html) 05:22:57 INFO - PROCESS | 1956 | RSS: Main: 265293824 05:22:57 INFO - PROCESS | 1956 | 05:25:59 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52334/tests/dromaeo/cssquery-mootools.html) 05:26:00 INFO - PROCESS | 1956 | RSS: Main: 268963840 05:26:00 INFO - PROCESS | 1956 | 05:29:02 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52334/tests/dromaeo/cssquery-prototype.html) 05:29:02 INFO - PROCESS | 1956 | RSS: Main: 268693504 05:29:02 INFO - PROCESS | 1956 | 05:32:05 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52334/tests/dromaeo/cssquery-yui.html) 05:32:06 INFO - PROCESS | 1956 | RSS: Main: 274079744 05:32:06 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:52334/tests/dromaeo/cssquery-yui.html (next: http://localhost:52334/tests/dromaeo/cssquery-dojo.html) 05:35:09 INFO - PROCESS | 1956 | RSS: Main: 276844544 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | __start_tp_report 05:35:09 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 05:35:09 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 05:35:09 INFO - PROCESS | 1956 | |i|pagename|runs| 05:35:09 INFO - PROCESS | 1956 | |0;dojo.html;2758.310422394403;3373.5445714828497;3405.1997780521574;3411.4712219605963;3417.692407683308;5560.749766260518;5635.971820140899;5658.547316214704;5695.971520142393;5753.050746626802;5643.463870932265;5650.434956504348;5702.77188912444;5703.885922281552;5709.800156994506;5168.508991645787;5234.712090835012;5257.211418287268;5302.946970530304;5303.761330740126;5178.6116041297055;5282.498162674539;5292.470752924696;5306.151015837467;5340.145576707728;5278;5321.281626980366;5328.76020579071;5336.9859726652;5347.54545863602;5085.949140508585;5121.948780512184;5146.588272938194;5178.093833579109;5240.161574148118;4940.25896115582;5113;5184.585233181337;5253.106971814801;5279.181726832308;4635.235186194274;5356;5654.208410822488;5666.433356664342;5707.571932105108;6098.795324190776;6102.572819902609;6162.198914141178;6195.963977650964;6264.655443950581;6158.6612736299485;6228.781992630236;6295.2760432550385;6296.685165741695;6308.148399965991;4817.78319975602;4849.224124140156;4860.246661767432;4916.58209052231;5829.183914252008;5966.701664916737;6186.10301506279;6242.563020588515;6260.561760676709;6294.339094395023;6095.542834287357;6109.572329936862;6138.600990935575;6154.169187159766;6243.219597550306;5269.394019687785;5684.317881854204;6066.726997285133;6189.566730328834;6265.8120256392385;4997.900041999213;6030.125631783367;6183.628982261079;6245.281792593819;6250.718602686438;6145.740123274718;6156.476699480505;6160.722767475474;6224.875502489925;6242.843928901723;4144.647704945113;4904.166291730415;4909.729964851967;4909.754512274372;4975.502449754996;4338.3709362142945;4436.44544431946;4441.311596702516;4459.464864216315;4469.553044695569;5687.43125687428;5720.542356611461;5783.971080144656;5810.564207684356;5928.347881733006;6166.920788861931;6181;6189.690515474298;6215.564910456315;6218.284897236786;5830.679312637845;5877.882442351214;5892.381299963527;5902.468777810018;5927.140564618193;5264.710440925785;5340.91988620171;5362.785488580491;5373.2208829719475;5399.379071406838;6333.96833015832;6336.809895703136;6344.6827658616885;6354.6822658867795;6364.204474440695;6226.128342032029;6262.780802671885;6279.937200627935;6292.685365731603;6298.748050077946;6159.168512250789;6190.102435146969;6190.721417536131;6208.379162083756;6339.587926784744;6152.230971128609;6172.043333283348;6208.4722798562625;6218.378162183745;6226.066090086523;6237.126802247598;6257.374262573706;6294.71673774672;6305.054241863757;6309.305976342691;5873.207117039316;5960.433758792908;6037.215162028908;6118.785842495491;6136.32500424944;6042.335343112342;6098.422650146753;6115.149072927182;6153.4769544587425;6155.815325540241;5639.379668236573;5943.316518600416;5956.583039187389;5960.5827592068135;5982.730777115127;5927.8221653350465;5975.641461512323;6010.128531363015;6089;6140.754369825336;5929.851753706192;5973.163757073926;5993.70031498432;6001.279846418283;6040.486558642565 05:35:09 INFO - PROCESS | 1956 | |1;ext.html;452.9479109902358;496.0005588738691;513.5583398277481;518.4452635679825;521.2181727408887;37863.621363786355;39668.809935701975;39676.80161599191;39833.80498585044;41972.790136049356;40850.59149408505;41214.38178427319;41232.38151427724;41335;41452.37821432673;9445.669401570947;9625.37435066722;9629.325947183665;9659.130678238957;9670.323077384586;9474.005229450911;9552.856707149398;9554.235661147126;9558.187554057913;9566.043395660414;9555.18780903624;9574.52127393631;9589.232861371109;9596.952015239915;9624.181944534723;9520.952395238015;9548.236141108695;9559.999999999965;9576.329656924017;9598.088181622734;9406.670766523139;9484.762880927963;9525.04749525042;9534.189593884528;9546.284028697875;32660.673393266;38817.44730210788;39381.01547461308;39396;39408.408873866916;3169.4770362890094;3254.5280934264397;3303.174206448388;3374.156460884779;3450.8102054387;30333.848330758425;30763.846180768953;30810.84594577035;31215.375692486024;31659.20851978719;3220.4686226772556;3221.114193596756;3243.497257925025;3337.0155804037868;3349.0287816533178;475186;478181;479915.9999999965;481750;482098;45532.77233613877;53019.46980530222;53053.46946530562;53097.734511327966;53230.20154697682;57310.713446433336;57629;57640.71179644159;57850.42149578535;57863.13205301924;15759.763603545956;15828.920855395649;16020.839791601935;16025.278862451218;16054.759178612096;12292.323922184187;12447.377631118408;12476.81284780729;12504.187227830162;12516.561920332926;13697.178169309873;15205.467808626867;15280.770788438182;15811.367545298059;15932.681346373007;3179.6343420506473;6257.499400047986;6539.574927629689;6551.672416379162;6580.309067547934;876.7764220123828;966.4587830814767;997.9600815967425;1033.3593172233263;1056.4084112896649;29693.554596681068;29789.255268618024;29864;30248.243793904887;30257.546136807967;1025.6666583360438;1032.1381646325403;1074.5003573338436;1113.8440618313443;1135.6649788312302;13494.460221591027;14862.777058344134;15412.537623871302;15708.371665133267;16494.75257871133;659863;663832;667720;673540;674213;56688.882111484265;57063;57098;57214.14178787322;57386;1308.1627758234738;1338.8058731484075;1365.0103674835864;1367.924764137962;1374.615107769826;25007.374815629755;28710.856445717636;29402.852985734935;30090.398192036475;30773.692263077977;53355.73322133364;54019.45980540144;54259.72870135624;54351;54372.184417234566;614753.926230366;618933;622646.8867655633;622739;623004;26131.869340653175;26835;27050.72949270482;40980.79509602433;41422;44792.328115077646;45587.86030349268;45850.31224531568;45934.31098533458;46439.53560464352;37978.73350897071;38099.61900380961;38191.427128592535;38805.6119438802;39565.60434395734;37753;37772.43341349827;37903;38880.80559597184;38928;35371.29257414786;36732.632673673994;37191.44212836864;37347.81326093461;37415.81292093522;26833.329166770985;29146.125616231548;30382.84808575943;30933.381332373676;33096.338073237916;22576;22984.885075574515;25041.74958250394;25342;26036.183306088435 05:35:09 INFO - PROCESS | 1956 | |2;jquery.html;371.9107414220587;373.2162458836443;374.1245485563779;384.3466107617048;395.50759304665695;18828.623427531442;19274.421767346983;19692.90153549232;19821.603567928632;19826.603467930632;19274.51813704658;19703.60592788147;19951.501212469695;19952.30166944157;20268.189272429085;4661.65037622178;5739.253896993385;6047.637141771508;6054.212952316193;6590.538662293641;6579.703913323912;6677.332266773333;6682.766103186389;6698.799036028927;6721.596704197739;5561.555075593963;5563.36021357543;5907.6750778707155;5950.494207992304;6009.1587177795145;5443.972780136074;5944.197533333009;5979.2824861016525;6001.9699901500435;6011.458968692817;5705.62913410627;5735.455131762517;5735.598508104435;5738.483536481736;5741.540676745851;12730.80903786444;12909;19730;20791.376258712262;24632.261032169063;2100.884451355175;2190.912363505458;2413.9396515087087;2466.0382450844186;2830.3207230264793;9450.102240287162;9648.228141748643;9818.312718109735;10131.392116473035;10200.897991020143;1800.3788692900928;1818.1818181818235;1858.6189831084596;1871.1579789094963;1886.7830199527093;123034;128600.35699821534;129860.35069824685;129997;131958.3402082993;9027.909720902839;11137.610183643696;11139.665810025712;11273.605423810128;11541.538338466535;11900.404979750978;13822.37799299014;14097.647558811112;14109.647258818406;14170.85829141716;6938.479614028968;8126.796830079295;8221.380984248444;8321.6671333146;8391.706290279812;7718.459707820399;7810.414218933603;8341.749747507585;8500.957495212484;8577.828443431097;3541.29174165168;4072.6538244249573;4319.632831209319;4359.022987932077;4467.218236808546;1506.811648543932;1612.9596760081092;1888.7261347104593;1897.0799162406222;1924.5381108533852;846.3229416466802;872.2698300458396;877.4077497689034;884.380933346647;885.4731434796286;19613.80386196148;20601.763894166397;20615.587688246153;20804.47988800292;20891.433142514372;966.7341481092615;967.3422072990434;988.7874107067015;992.6327258914248;996.4818294486827;10176.898231017594;10868.184886133571;10869.619563315246;10870.293430926964;10905.83641245382;453845;566919;577745;583841;587231;136214;141450;142539;143034;146868;962.8507581324906;989.6585677941099;1013.9645112421177;1016.1413605503337;1020.6580795433464;18188.727169092737;18971.33600323982;19006.524836879187;19044.85730856153;19102.90448547804;53076.73461632667;55038.17442738442;55276;55462.44537554573;55910.806689499266;49127;66562.67030653903;75422;77351.2264877344;83984;6981.895271571032;7861;7956.2441568050945;8022.077461091816;8072.233137851895;8095.7166499172245;12294.89345958868;12411.193272437262;12647.051471139517;12697.682557935756;10919.962603552649;10938.295514670004;11042.779144417227;11110.055645269918;11148.219624626197;10495.632652857113;10512.316699414514;10782.406967616856;11047.668569942914;11159.44202789841;10437.703705185151;10811.405372704578;11037.558497660004;11126.554937802397;11187.832182517432;7781.805454863674;7970.322522585413;7999.520028798291;8103.797405064921;8146.714864979697;10146.949265253626;10690.518926648165;10768.246222764332;11058.944705276423;11129.610463633733 05:35:09 INFO - PROCESS | 1956 | |3;mootools.html;1359.2592037339648;1511.6749898771766;1601.4635097242424;1709.1881356355725;1747.4320845725135;7844.764657060283;8105.91894081059;8348.916510834897;8905.554722263878;8923.643054277829;8375.036870759865;8650.91349086509;8664.133586641348;8666.6100025499;8748.431351962117;1948.8538359623014;2319.072371051576;2327.650852372141;2331.6385960176117;2334.5214231082587;2299.356180269519;2328.2433209206993;2357.882105894707;2359.162497313455;2362.3739708977137;2329.24299602629;2342.1334106380664;2350.7766762157567;2358.481134150484;2359.304005318435;2306.953860922789;2315.8378913476063;2320.8027317678016;2326.057946531649;2333.1250780957057;1953.5604488990007;1999.6902029170917;2303.2744685424036;2305.72331320241;2321.7678232176645;8484.151584841527;8803.119688031209;8822.911770882338;8825.955870220609;8847.867281990775;5117.795288188468;5189.714565698885;5259.105951988171;5262.105442074818;5265.9994601026065;3294.5387645729616;3370.140614143402;3411.795292282446;3437.295354452331;3653.725970552193;1072.860528131338;1073.538378497246;1077.735954691098;1079.22835172851;1102.3385968418966;11378.943105284503;11395;11473.713157171054;11515.36665483398;11520.020798232077;4442.067165895133;4605.93091103627;4697;4706.129366067288;4718.787654555554;9699.903000970042;9780.41317520951;9780.853287200698;9787.119159275699;9814.165795907285;5182.378114626269;5228.738563071831;5237.869053273698;5244.868878277997;5254.500822421864;4264.978675106605;4385.736855788663;4714.858554243378;4783.521647835189;4806.351142595705;3361.83190840457;3648.7810731356203;3804.543454785388;3917.5103112110987;3918.431827385013;1084.707129075161;1234.2779474007807;1246.3020708403324;1254.5295514182183;1265.702559898423;720.3840716187689;743.4052757793744;809.29591255608;856.8629019356997;883.9823203535893;4855.708657480563;5127.564157046618;5283.788648454019;5898.469137777534;5931.970340148272;930.3673502018693;939.5443210043123;959.7456673981261;975.8341082016075;1013.2451323763696;3753.5871054184017;3799.772013679188;3848.191879705237;3922.941155882664;3963.8810835674976;10276.075153236245;10710.625128120635;10737.087347575543;10740.73148171302;10794.56821727122;10682.679519614425;10705.785884282272;10708.250422470508;10718.410487423267;10730.624428144978;7615.771526854092;8093.231143041402;8231.670733170726;8245.175482451707;8270.917290827014;5763.135529670583;5905.173275741314;5950.702464876826;6010.9699451502465;6052.364501727256;9207.585658645243;9468.384555003902;9746.512674366395;9834.508274586098;9864.358816676893;9677.806443870943;9779.070988256104;9929.553170107218;9938;10155.187584993035;7306.3789577884345;7357.301056399633;7929.167437419219;8003.599820009093;8083.19168083187;8095.352371810123;8204.261616454547;8234.464759790595;8252.381071419548;8274.669013239403;7273.599952002691;7407.074115735533;7433.442491813027;7439.107307122963;7491;7142.357187853118;7258.963705181441;7309.086364204474;7359.1169059713175;7382.224866388952;6871.656417179221;6938.653067346511;7002.684879180347;7006.9649651751415;7007.159140902921;4762.261849413347;4879.170541007966;4981.078500477423;4986.252062190701;5041.773120209673;4675.4155730533685;4723.905521889475;4795.784189711541;4957.231629097496;5077.238414237746 05:35:09 INFO - PROCESS | 1956 | |4;prototype.html;301.1357404249803;302.7608189530271;311.4052160373686;315.0799664978263;315.3267773303995;4563.307648487392;5353.223782551528;5538.252335934648;5557;5746.16680581316;4694.4601370842365;5337.7456297769995;5369.120812710076;5552.3892371839065;5559.527440167591;3468.7745296555768;4067.8169482373214;4104.938425923614;4192;4251.4898212214575;3684.926301473969;3924.50943632046;4276.828926842923;4279.683245484759;4296.914061718764;3309.9834500827583;4019.859304924328;4144.254034273829;4172;4193.979030104845;3366.0406784066545;3402.659734026602;3962.227365663711;4168.791560421967;4257.254980378421;3459.39460594395;3610.3862343401684;3626.691731202851;3626.9274614507826;3634.27314537091;4639.30410438437;5098.056859481007;5421.268128802601;5475.342958844924;5498.230247765276;4195.91608167838;4280.336547835091;4556.334544291561;4801.759912004386;4826.517348265145;5219.982103489783;5669.348024977139;5924.437178468039;5951.821445356646;6036.245469316335;3387.8644854205804;3615.692666123383;3750.1608767535695;3930.606939306075;3940;4984.77568509418;5059.519345662156;6020.127081573148;6230.626162430269;6230.688465576703;3854.2676891390547;4018.1561872006623;4025.496812898388;4033.415154802537;4049.7367671101283;3591;4036.4348991141264;4058.4723985881647;4065.4918135233097;4069.654079403284;3815.484909537177;4775.707660322995;4779.713217206979;4782.163121453732;4822.252550854553;5377.623566350396;5930.28836539618;5975.223220981245;6011.549133814981;6013.7895173669585;1039.6309310194922;1295.6307452376216;1336.8395792504962;1341.9798703019462;1391.9560329752685;865.2818160926416;880.366136381804;900.6127365233012;922.6678395777515;925.4956048953202;4975.502449754996;5283;5436.885438485101;5520.585956053312;5563.553476096163;4594.748573199108;5697.515711164515;5958.880822383528;6014.789482368096;6049.969750151221;5050.747462626854;5065.746712664352;5174.680456483573;5240.554552863049;5242.217646000378;2981.567672687448;3231.2228274448958;3250.8374581271314;3251.512273159045;3267.738580913569;5580.2745643066955;6280.5603607747935;6290.465310448663;6309.842253943688;6410.583312084699;5568.248286481273;5737.598368114275;5871.706414679249;6241.875162496724;6306.49548036156;6075.422834830684;6362.840928976812;6381.6285844195945;6387.425131738073;6413.839654008687;5244.816431424882;5776.989026920188;5959.757297636822;6049.606775559574;6167.722452489559;5962.956482615612;5992.67040312787;6064.969675151596;6078.027515597483;6104.481119104926;5564.57616195134;5962.433568810956;6010.459058684739;6382.3617638237665;6382.6170429774365;3394.7284217262068;3866.69066474687;4015.377616469452;4028.113814960704;4037.2329257442166;5943.91084133747;6171.691415429121;6201.3178550358525;6232.439080482778;6242.968785156045;5145.945081258408;5320.414754377093;5798.275215598051;6025.216721826135;6042.939570604238;5232.11054120808;5366.946330536801;6025.849353766191;6029.487493563096;6086.482648974887;4885.5358740919555;5232.5552328052545;5656.6888821115235;5714.771324165325;5867.6772777497645;4408.669349798842;5021.824236151717;5120.590352771844;5820.621659592113;6109.541784366102;4474.463064432289;5145.845624631267;5427.236148251755;5859.970700146472;5898.546597318997 05:35:09 INFO - PROCESS | 1956 | |5;yui.html;685.2599192871699;722.81568200109;756.4100001998443;779.8596252674516;795.634008356156;14750.852491475081;15971.520854374387;15998.440054598092;16057.999999999985;16106.91946540267;14189.361478733455;14312.642183945407;14337.713245735105;14364.784528232085;14365.281735913215;645.0743183531623;672.3948446398232;798.8601994650942;800.2437696376926;824.9422540422173;791.9168487308837;822.7408366364606;823.1644880446352;824.9587520623945;825.1748251748252;872.6422166911567;880.2341962492641;881.352206128495;881.722257488889;882.3779235638891;699.3321378083917;731.381982225019;759.9886001709979;768.9926196682364;878.0648609231148;547.2721280696663;631.6746875359194;649.4966401039185;654.8755736410067;655.3872129558878;12969.87030129696;12977.480900764052;12995.675108122277;13012.739745205043;13013.21920684762;14236.217008064552;14309.642258943506;14341.928290358586;14356.282185890665;14375.209363485004;11740.647780566596;11895;11947.402629868471;11967;12002.63992080239;3705.814709264526;3761.6050314716836;3769;3881.9805900970596;3894.824732887027;116371.20963000537;118534.40732796367;118841.40579297135;119501.8049819508;119858.99999999913;10447.738806529898;11053.889461105286;11088.778224435466;11216.775664486664;11271.887281127249;22509.212177573707;22545.32364029082;22592.887035564716;22598.661020084714;22605.773942260366;7759.456838021284;7780.260875216845;7901.604919754104;8103.635336409876;8104.27061564462;4081.5918408158946;4114.465119534441;4192.664586833107;4197.349410841324;4328.04782947751;3565.4651802229873;3663.120850995742;3679.0802299425145;3689.4834723138783;3693.4459831025024;552.2351543112818;555.2781384200523;623.8627501949563;652.1326635574675;652.729117416267;634.511426201822;650.9641969691712;656.5535435903536;658.8023592922104;667.2293501006345;7888.1323054463965;8748.1251874812;9110.954445227731;9304.441733496013;9463.90536094644;634.2737565487491;643.9001954697029;649.6913965866175;656.7537173559915;658.1476987301456;4141.8964525886495;4177.874663760092;4363.672724545671;4390.846320378771;4597.931031034537;166178;167528;167600;170490;172575;137704;139576;139892;141397;143578.28210859088;123916.07552602797;124491;125276.37361813315;130306.34846825895;130327.34836325947;7549;8728;8988.46069235848;8995.775105622412;9200.6779762708;54319.45680543144;69381.65309173422;69891.65054174696;69961.65019174872;69964.6501767488;104489;105392.47303763739;105559;105765;105982;11428.028617567268;11818.704532386759;11927.165098443025;11997.700057498283;12389.814152787536;12733.61799146027;12803.03977201695;12979.091463597457;13385;13482.797758033441;10129.442880641636;11387.715307117389;11854.94072529632;11903.047756179312;12224;11930.463129159036;12020.158588898694;12214.633560993185;12495.750084998432;12543.749125017266;12033.398330083635;12062.879371206176;12177.817332740193;12296.077794165294;12447;10306.12397946183;10378.584856605954;10515.631952881613;10563.524641391003;10665.840012399665;8239.464434811718;8405.579721014046;9518.476483793182;10179.898201017895;10504.159667226451 05:35:09 INFO - PROCESS | 1956 | __end_tp_report 05:35:09 INFO - PROCESS | 1956 | __start_cc_report 05:35:09 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,369 05:35:09 INFO - PROCESS | 1956 | __end_cc_report 05:35:09 INFO - PROCESS | 1956 | __startTimestamp1476189309606__endTimestamp 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | ------- Summary: start ------- 05:35:09 INFO - PROCESS | 1956 | Number of tests: 6 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5690.88 Median:5943.32 stddev:670.72 (11.3%) stddev-sans-first:632.10 05:35:09 INFO - PROCESS | 1956 | Values: 2758.3 3373.5 3405.2 3411.5 3417.7 5560.7 5636.0 5658.5 5696.0 5753.1 5643.5 5650.4 5702.8 5703.9 5709.8 5168.5 5234.7 5257.2 5302.9 5303.8 5178.6 5282.5 5292.5 5306.2 5340.1 5278.0 5321.3 5328.8 5337.0 5347.5 5085.9 5121.9 5146.6 5178.1 5240.2 4940.3 5113.0 5184.6 5253.1 5279.2 4635.2 5356.0 5654.2 5666.4 5707.6 6098.8 6102.6 6162.2 6196.0 6264.7 6158.7 6228.8 6295.3 6296.7 6308.1 4817.8 4849.2 4860.2 4916.6 5829.2 5966.7 6186.1 6242.6 6260.6 6294.3 6095.5 6109.6 6138.6 6154.2 6243.2 5269.4 5684.3 6066.7 6189.6 6265.8 4997.9 6030.1 6183.6 6245.3 6250.7 6145.7 6156.5 6160.7 6224.9 6242.8 4144.6 4904.2 4909.7 4909.8 4975.5 4338.4 4436.4 4441.3 4459.5 4469.6 5687.4 5720.5 5784.0 5810.6 5928.3 6166.9 6181.0 6189.7 6215.6 6218.3 5830.7 5877.9 5892.4 5902.5 5927.1 5264.7 5340.9 5362.8 5373.2 5399.4 6334.0 6336.8 6344.7 6354.7 6364.2 6226.1 6262.8 6279.9 6292.7 6298.7 6159.2 6190.1 6190.7 6208.4 6339.6 6152.2 6172.0 6208.5 6218.4 6226.1 6237.1 6257.4 6294.7 6305.1 6309.3 5873.2 5960.4 6037.2 6118.8 6136.3 6042.3 6098.4 6115.1 6153.5 6155.8 5639.4 5943.3 5956.6 5960.6 5982.7 5927.8 5975.6 6010.1 6089.0 6140.8 5929.9 5973.2 5993.7 6001.3 6040.5 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:71275.20 Median:39487.01 stddev:159251.40 (403.3%) stddev-sans-first:159609.36 05:35:09 INFO - PROCESS | 1956 | Values: 452.9 496.0 513.6 518.4 521.2 37863.6 39668.8 39676.8 39833.8 41972.8 40850.6 41214.4 41232.4 41335.0 41452.4 9445.7 9625.4 9629.3 9659.1 9670.3 9474.0 9552.9 9554.2 9558.2 9566.0 9555.2 9574.5 9589.2 9597.0 9624.2 9521.0 9548.2 9560.0 9576.3 9598.1 9406.7 9484.8 9525.0 9534.2 9546.3 32660.7 38817.4 39381.0 39396.0 39408.4 3169.5 3254.5 3303.2 3374.2 3450.8 30333.8 30763.8 30810.8 31215.4 31659.2 3220.5 3221.1 3243.5 3337.0 3349.0 475186.0 478181.0 479916.0 481750.0 482098.0 45532.8 53019.5 53053.5 53097.7 53230.2 57310.7 57629.0 57640.7 57850.4 57863.1 15759.8 15828.9 16020.8 16025.3 16054.8 12292.3 12447.4 12476.8 12504.2 12516.6 13697.2 15205.5 15280.8 15811.4 15932.7 3179.6 6257.5 6539.6 6551.7 6580.3 876.8 966.5 998.0 1033.4 1056.4 29693.6 29789.3 29864.0 30248.2 30257.5 1025.7 1032.1 1074.5 1113.8 1135.7 13494.5 14862.8 15412.5 15708.4 16494.8 659863.0 663832.0 667720.0 673540.0 674213.0 56688.9 57063.0 57098.0 57214.1 57386.0 1308.2 1338.8 1365.0 1367.9 1374.6 25007.4 28710.9 29402.9 30090.4 30773.7 53355.7 54019.5 54259.7 54351.0 54372.2 614753.9 618933.0 622646.9 622739.0 623004.0 26131.9 26835.0 27050.7 40980.8 41422.0 44792.3 45587.9 45850.3 45934.3 46439.5 37978.7 38099.6 38191.4 38805.6 39565.6 37753.0 37772.4 37903.0 38880.8 38928.0 35371.3 36732.6 37191.4 37347.8 37415.8 26833.3 29146.1 30382.8 30933.4 33096.3 22576.0 22984.9 25041.7 25342.0 26036.2 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:33954.29 Median:13549.15 stddev:93989.12 (693.7%) stddev-sans-first:94218.96 05:35:09 INFO - PROCESS | 1956 | Values: 371.9 373.2 374.1 384.3 395.5 18828.6 19274.4 19692.9 19821.6 19826.6 19274.5 19703.6 19951.5 19952.3 20268.2 4661.7 5739.3 6047.6 6054.2 6590.5 6579.7 6677.3 6682.8 6698.8 6721.6 5561.6 5563.4 5907.7 5950.5 6009.2 5444.0 5944.2 5979.3 6002.0 6011.5 5705.6 5735.5 5735.6 5738.5 5741.5 12730.8 12909.0 19730.0 20791.4 24632.3 2100.9 2190.9 2413.9 2466.0 2830.3 9450.1 9648.2 9818.3 10131.4 10200.9 1800.4 1818.2 1858.6 1871.2 1886.8 123034.0 128600.4 129860.4 129997.0 131958.3 9027.9 11137.6 11139.7 11273.6 11541.5 11900.4 13822.4 14097.6 14109.6 14170.9 6938.5 8126.8 8221.4 8321.7 8391.7 7718.5 7810.4 8341.7 8501.0 8577.8 3541.3 4072.7 4319.6 4359.0 4467.2 1506.8 1613.0 1888.7 1897.1 1924.5 846.3 872.3 877.4 884.4 885.5 19613.8 20601.8 20615.6 20804.5 20891.4 966.7 967.3 988.8 992.6 996.5 10176.9 10868.2 10869.6 10870.3 10905.8 453845.0 566919.0 577745.0 583841.0 587231.0 136214.0 141450.0 142539.0 143034.0 146868.0 962.9 989.7 1014.0 1016.1 1020.7 18188.7 18971.3 19006.5 19044.9 19102.9 53076.7 55038.2 55276.0 55462.4 55910.8 49127.0 66562.7 75422.0 77351.2 83984.0 6981.9 7861.0 7956.2 8022.1 8072.2 8095.7 12294.9 12411.2 12647.1 12697.7 10920.0 10938.3 11042.8 11110.1 11148.2 10495.6 10512.3 10782.4 11047.7 11159.4 10437.7 10811.4 11037.6 11126.6 11187.8 7781.8 7970.3 7999.5 8103.8 8146.7 10146.9 10690.5 10768.2 11058.9 11129.6 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:5625.96 Median:5014.01 stddev:3177.02 (63.4%) stddev-sans-first:3169.75 05:35:09 INFO - PROCESS | 1956 | Values: 1359.3 1511.7 1601.5 1709.2 1747.4 7844.8 8105.9 8348.9 8905.6 8923.6 8375.0 8650.9 8664.1 8666.6 8748.4 1948.9 2319.1 2327.7 2331.6 2334.5 2299.4 2328.2 2357.9 2359.2 2362.4 2329.2 2342.1 2350.8 2358.5 2359.3 2307.0 2315.8 2320.8 2326.1 2333.1 1953.6 1999.7 2303.3 2305.7 2321.8 8484.2 8803.1 8822.9 8826.0 8847.9 5117.8 5189.7 5259.1 5262.1 5266.0 3294.5 3370.1 3411.8 3437.3 3653.7 1072.9 1073.5 1077.7 1079.2 1102.3 11378.9 11395.0 11473.7 11515.4 11520.0 4442.1 4605.9 4697.0 4706.1 4718.8 9699.9 9780.4 9780.9 9787.1 9814.2 5182.4 5228.7 5237.9 5244.9 5254.5 4265.0 4385.7 4714.9 4783.5 4806.4 3361.8 3648.8 3804.5 3917.5 3918.4 1084.7 1234.3 1246.3 1254.5 1265.7 720.4 743.4 809.3 856.9 884.0 4855.7 5127.6 5283.8 5898.5 5932.0 930.4 939.5 959.7 975.8 1013.2 3753.6 3799.8 3848.2 3922.9 3963.9 10276.1 10710.6 10737.1 10740.7 10794.6 10682.7 10705.8 10708.3 10718.4 10730.6 7615.8 8093.2 8231.7 8245.2 8270.9 5763.1 5905.2 5950.7 6011.0 6052.4 9207.6 9468.4 9746.5 9834.5 9864.4 9677.8 9779.1 9929.6 9938.0 10155.2 7306.4 7357.3 7929.2 8003.6 8083.2 8095.4 8204.3 8234.5 8252.4 8274.7 7273.6 7407.1 7433.4 7439.1 7491.0 7142.4 7259.0 7309.1 7359.1 7382.2 6871.7 6938.7 7002.7 7007.0 7007.2 4762.3 4879.2 4981.1 4986.3 5041.8 4675.4 4723.9 4795.8 4957.2 5077.2 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:4703.77 Median:5236.55 stddev:1496.27 (28.6%) stddev-sans-first:1463.53 05:35:09 INFO - PROCESS | 1956 | Values: 301.1 302.8 311.4 315.1 315.3 4563.3 5353.2 5538.3 5557.0 5746.2 4694.5 5337.7 5369.1 5552.4 5559.5 3468.8 4067.8 4104.9 4192.0 4251.5 3684.9 3924.5 4276.8 4279.7 4296.9 3310.0 4019.9 4144.3 4172.0 4194.0 3366.0 3402.7 3962.2 4168.8 4257.3 3459.4 3610.4 3626.7 3626.9 3634.3 4639.3 5098.1 5421.3 5475.3 5498.2 4195.9 4280.3 4556.3 4801.8 4826.5 5220.0 5669.3 5924.4 5951.8 6036.2 3387.9 3615.7 3750.2 3930.6 3940.0 4984.8 5059.5 6020.1 6230.6 6230.7 3854.3 4018.2 4025.5 4033.4 4049.7 3591.0 4036.4 4058.5 4065.5 4069.7 3815.5 4775.7 4779.7 4782.2 4822.3 5377.6 5930.3 5975.2 6011.5 6013.8 1039.6 1295.6 1336.8 1342.0 1392.0 865.3 880.4 900.6 922.7 925.5 4975.5 5283.0 5436.9 5520.6 5563.6 4594.7 5697.5 5958.9 6014.8 6050.0 5050.7 5065.7 5174.7 5240.6 5242.2 2981.6 3231.2 3250.8 3251.5 3267.7 5580.3 6280.6 6290.5 6309.8 6410.6 5568.2 5737.6 5871.7 6241.9 6306.5 6075.4 6362.8 6381.6 6387.4 6413.8 5244.8 5777.0 5959.8 6049.6 6167.7 5963.0 5992.7 6065.0 6078.0 6104.5 5564.6 5962.4 6010.5 6382.4 6382.6 3394.7 3866.7 4015.4 4028.1 4037.2 5943.9 6171.7 6201.3 6232.4 6243.0 5145.9 5320.4 5798.3 6025.2 6042.9 5232.1 5366.9 6025.8 6029.5 6086.5 4885.5 5232.6 5656.7 5714.8 5867.7 4408.7 5021.8 5120.6 5820.6 6109.5 4474.5 5145.8 5427.2 5860.0 5898.5 05:35:09 INFO - PROCESS | 1956 | 05:35:09 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:26628.49 Median:22602.22 stddev:44637.91 (197.5%) stddev-sans-first:44720.63 05:35:09 INFO - PROCESS | 1956 | Values: 685.3 722.8 756.4 779.9 795.6 14750.9 15971.5 15998.4 16058.0 16106.9 14189.4 14312.6 14337.7 14364.8 14365.3 645.1 672.4 798.9 800.2 824.9 791.9 822.7 823.2 825.0 825.2 872.6 880.2 881.4 881.7 882.4 699.3 731.4 760.0 769.0 878.1 547.3 631.7 649.5 654.9 655.4 12969.9 12977.5 12995.7 13012.7 13013.2 14236.2 14309.6 14341.9 14356.3 14375.2 11740.6 11895.0 11947.4 11967.0 12002.6 3705.8 3761.6 3769.0 3882.0 3894.8 116371.2 118534.4 118841.4 119501.8 119859.0 10447.7 11053.9 11088.8 11216.8 11271.9 22509.2 22545.3 22592.9 22598.7 22605.8 7759.5 7780.3 7901.6 8103.6 8104.3 4081.6 4114.5 4192.7 4197.3 4328.0 3565.5 3663.1 3679.1 3689.5 3693.4 552.2 555.3 623.9 652.1 652.7 634.5 651.0 656.6 658.8 667.2 7888.1 8748.1 9111.0 9304.4 9463.9 634.3 643.9 649.7 656.8 658.1 4141.9 4177.9 4363.7 4390.8 4597.9 166178.0 167528.0 167600.0 170490.0 172575.0 137704.0 139576.0 139892.0 141397.0 143578.3 123916.1 124491.0 125276.4 130306.3 130327.3 7549.0 8728.0 8988.5 8995.8 9200.7 54319.5 69381.7 69891.7 69961.7 69964.7 104489.0 105392.5 105559.0 105765.0 105982.0 11428.0 11818.7 11927.2 11997.7 12389.8 12733.6 12803.0 12979.1 13385.0 13482.8 10129.4 11387.7 11854.9 11903.0 12224.0 11930.5 12020.2 12214.6 12495.8 12543.7 12033.4 12062.9 12177.8 12296.1 12447.0 10306.1 10378.6 10515.6 10563.5 10665.8 8239.5 8405.6 9518.5 10179.9 10504.2 05:35:09 INFO - PROCESS | 1956 | -------- Summary: end -------- 05:35:09 INFO - PROCESS | 1956 | 05:35:10 INFO - TEST-INFO | 1956: exit 0 05:35:10 INFO - TEST-OK | dromaeo_css | took 1115756ms 05:35:10 INFO - TEST-START | kraken 05:35:10 INFO - operating with platform_type : mac_ 05:35:10 INFO - Initialising browser for kraken test... 05:35:10 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp3UWM2H/profile http://localhost:52334/getInfo.html) 05:35:13 INFO - PROCESS | 1962 | 2016-10-11 05:35:13.069 plugin-container[1963:18382] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 05:35:13 INFO - PROCESS | 1962 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:35:13 INFO - PROCESS | 1962 | 2016-10-11 05:35:13.073 plugin-container[1963:18382] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 05:35:13 INFO - PROCESS | 1962 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:35:13 INFO - PROCESS | 1962 | 2016-10-11 05:35:13.073 plugin-container[1963:18382] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:35:13 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 05:35:13 INFO - PROCESS | 1962 | colorDepth:24 05:35:13 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 05:35:13 INFO - PROCESS | 1962 | __metrics 05:35:13 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 05:35:13 INFO - TEST-INFO | 1962: exit 0 05:35:13 INFO - Browser initialized. 05:35:13 INFO - Running cycle 1/1 for kraken test... 05:35:13 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp3UWM2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:16 INFO - PROCESS | 1964 | 2016-10-11 05:35:16.344 plugin-container[1965:18501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 05:35:16 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:35:16 INFO - PROCESS | 1964 | 2016-10-11 05:35:16.345 plugin-container[1965:18501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 05:35:16 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:35:16 INFO - PROCESS | 1964 | 2016-10-11 05:35:16.345 plugin-container[1965:18501] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:35:25 INFO - PROCESS | 1964 | RSS: Main: 238718976 05:35:25 INFO - PROCESS | 1964 | 05:35:29 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52334/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:30 INFO - PROCESS | 1964 | RSS: Main: 252203008 05:35:30 INFO - PROCESS | 1964 | 05:35:32 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52334/tests/kraken/driver.html?testName=audio-dft) 05:35:33 INFO - PROCESS | 1964 | RSS: Main: 260808704 05:35:33 INFO - PROCESS | 1964 | 05:35:36 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52334/tests/kraken/driver.html?testName=audio-fft) 05:35:37 INFO - PROCESS | 1964 | RSS: Main: 260833280 05:35:37 INFO - PROCESS | 1964 | 05:35:39 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52334/tests/kraken/driver.html?testName=audio-oscillator) 05:35:40 INFO - PROCESS | 1964 | RSS: Main: 262901760 05:35:40 INFO - PROCESS | 1964 | 05:35:42 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:42 INFO - PROCESS | 1964 | RSS: Main: 263172096 05:35:42 INFO - PROCESS | 1964 | 05:35:45 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52334/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:46 INFO - PROCESS | 1964 | RSS: Main: 263802880 05:35:46 INFO - PROCESS | 1964 | 05:35:49 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52334/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:50 INFO - PROCESS | 1964 | RSS: Main: 264085504 05:35:50 INFO - PROCESS | 1964 | 05:35:53 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52334/tests/kraken/driver.html?testName=json-parse-financial) 05:35:54 INFO - PROCESS | 1964 | RSS: Main: 264187904 05:35:54 INFO - PROCESS | 1964 | 05:35:55 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:56 INFO - PROCESS | 1964 | RSS: Main: 263962624 05:35:56 INFO - PROCESS | 1964 | 05:35:58 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:58 INFO - PROCESS | 1964 | RSS: Main: 263966720 05:35:58 INFO - PROCESS | 1964 | 05:36:01 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:01 INFO - PROCESS | 1964 | RSS: Main: 264060928 05:36:01 INFO - PROCESS | 1964 | 05:36:04 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:05 INFO - PROCESS | 1964 | RSS: Main: 264282112 05:36:05 INFO - PROCESS | 1964 | 05:36:08 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:09 INFO - PROCESS | 1964 | RSS: Main: 264171520 05:36:09 INFO - PROCESS | 1964 | 05:36:10 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:52334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52334/tests/kraken/driver.html?testName=ai-astar) 05:36:11 INFO - PROCESS | 1964 | RSS: Main: 265928704 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | __start_tp_report 05:36:11 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 05:36:11 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 05:36:11 INFO - PROCESS | 1964 | |i|pagename|runs| 05:36:11 INFO - PROCESS | 1964 | |0;ai-astar;113;116;121;116;98;175;174;129;117;116 05:36:11 INFO - PROCESS | 1964 | |1;audio-beat-detection;147;119;115;154;115;121;118;141;157;119 05:36:11 INFO - PROCESS | 1964 | |2;audio-dft;210;215;265;281;198;257;222;198;198;206 05:36:11 INFO - PROCESS | 1964 | |3;audio-fft;86;61;52;96;80;86;49;74;107;85 05:36:11 INFO - PROCESS | 1964 | |4;audio-oscillator;90;71;85;74;69;70;87;72;70;89 05:36:11 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;114;86;90;85;88;85;92;114;89;88 05:36:11 INFO - PROCESS | 1964 | |6;imaging-darkroom;153;96;96;95;131;151;95;122;92;146 05:36:11 INFO - PROCESS | 1964 | |7;imaging-desaturate;145;88;153;151;119;101;139;147;147;131 05:36:11 INFO - PROCESS | 1964 | |8;json-parse-financial;55;57;54;57;56;57;57;57;55;57 05:36:11 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;68;97;67;75;73;69;70;73;73;74 05:36:11 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;89;90;106;105;89;90;105;116;111;105 05:36:11 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;151;163;154;142;152;148;183;169;225;146 05:36:11 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;171;173;175;173;173;176;177;177;180;177 05:36:11 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;73;70;72;72;70;71;72;71;67;75 05:36:11 INFO - PROCESS | 1964 | __end_tp_report 05:36:11 INFO - PROCESS | 1964 | __start_cc_report 05:36:11 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,971 05:36:11 INFO - PROCESS | 1964 | __end_cc_report 05:36:11 INFO - PROCESS | 1964 | __startTimestamp1476189371145__endTimestamp 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | ------- Summary: start ------- 05:36:11 INFO - PROCESS | 1964 | Number of tests: 14 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:127.50 Median:125.00 stddev:25.93 (20.7%) stddev-sans-first:26.96 05:36:11 INFO - PROCESS | 1964 | Values: 113.0 116.0 121.0 116.0 98.0 175.0 174.0 129.0 117.0 116.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:130.60 Median:131.00 stddev:17.09 (13.0%) stddev-sans-first:17.06 05:36:11 INFO - PROCESS | 1964 | Values: 147.0 119.0 115.0 154.0 115.0 121.0 118.0 141.0 157.0 119.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:225.00 Median:218.50 stddev:30.99 (14.2%) stddev-sans-first:32.39 05:36:11 INFO - PROCESS | 1964 | Values: 210.0 215.0 265.0 281.0 198.0 257.0 222.0 198.0 198.0 206.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:77.60 Median:82.50 stddev:18.76 (22.7%) stddev-sans-first:19.65 05:36:11 INFO - PROCESS | 1964 | Values: 86.0 61.0 52.0 96.0 80.0 86.0 49.0 74.0 107.0 85.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:8.84 (11.1%) stddev-sans-first:8.19 05:36:11 INFO - PROCESS | 1964 | Values: 90.0 71.0 85.0 74.0 69.0 70.0 87.0 72.0 70.0 89.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:88.00 stddev:11.23 (12.8%) stddev-sans-first:9.01 05:36:11 INFO - PROCESS | 1964 | Values: 114.0 86.0 90.0 85.0 88.0 85.0 92.0 114.0 89.0 88.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:117.70 Median:93.50 stddev:25.79 (27.6%) stddev-sans-first:23.98 05:36:11 INFO - PROCESS | 1964 | Values: 153.0 96.0 96.0 95.0 131.0 151.0 95.0 122.0 92.0 146.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:132.10 Median:147.00 stddev:22.45 (15.3%) stddev-sans-first:23.32 05:36:11 INFO - PROCESS | 1964 | Values: 145.0 88.0 153.0 151.0 119.0 101.0 139.0 147.0 147.0 131.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.12 05:36:11 INFO - PROCESS | 1964 | Values: 55.0 57.0 54.0 57.0 56.0 57.0 57.0 57.0 55.0 57.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:73.00 stddev:8.56 (11.7%) stddev-sans-first:8.80 05:36:11 INFO - PROCESS | 1964 | Values: 68.0 97.0 67.0 75.0 73.0 69.0 70.0 73.0 73.0 74.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:100.60 Median:102.50 stddev:10.15 (9.9%) stddev-sans-first:9.85 05:36:11 INFO - PROCESS | 1964 | Values: 89.0 90.0 106.0 105.0 89.0 90.0 105.0 116.0 111.0 105.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:158.50 stddev:24.90 (15.7%) stddev-sans-first:26.01 05:36:11 INFO - PROCESS | 1964 | Values: 151.0 163.0 154.0 142.0 152.0 148.0 183.0 169.0 225.0 146.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:176.50 stddev:2.70 (1.5%) stddev-sans-first:2.40 05:36:11 INFO - PROCESS | 1964 | Values: 171.0 173.0 175.0 173.0 173.0 176.0 177.0 177.0 180.0 177.0 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:2.11 (2.9%) stddev-sans-first:2.15 05:36:11 INFO - PROCESS | 1964 | Values: 73.0 70.0 72.0 72.0 70.0 71.0 72.0 71.0 67.0 75.0 05:36:11 INFO - PROCESS | 1964 | -------- Summary: end -------- 05:36:11 INFO - PROCESS | 1964 | 05:36:11 INFO - TEST-INFO | 1964: exit 0 05:36:11 INFO - TEST-OK | kraken | took 61722ms 05:36:11 INFO - SUITE-END | took 1177s 05:36:12 INFO - Completed test suite (00:19:37) 05:36:12 INFO - javascript benchmark 05:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7290.019142501479, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2758.310422394403, 3373.5445714828497, 3405.1997780521574, 3411.4712219605963, 3417.692407683308, 5560.749766260518, 5635.971820140899, 5658.547316214704, 5695.971520142393, 5753.050746626802, 5643.463870932265, 5650.434956504348, 5702.77188912444, 5703.885922281552, 5709.800156994506, 5168.508991645787, 5234.712090835012, 5257.211418287268, 5302.946970530304, 5303.761330740126, 5178.6116041297055, 5282.498162674539, 5292.470752924696, 5306.151015837467, 5340.145576707728, 5278.0, 5321.281626980366, 5328.76020579071, 5336.9859726652, 5347.54545863602, 5085.949140508585, 5121.948780512184, 5146.588272938194, 5178.093833579109, 5240.161574148118, 4940.25896115582, 5113.0, 5184.585233181337, 5253.106971814801, 5279.181726832308, 4635.235186194274, 5356.0, 5654.208410822488, 5666.433356664342, 5707.571932105108, 6098.795324190776, 6102.572819902609, 6162.198914141178, 6195.963977650964, 6264.655443950581, 6158.6612736299485, 6228.781992630236, 6295.2760432550385, 6296.685165741695, 6308.148399965991, 4817.78319975602, 4849.224124140156, 4860.246661767432, 4916.58209052231, 5829.183914252008, 5966.701664916737, 6186.10301506279, 6242.563020588515, 6260.561760676709, 6294.339094395023, 6095.542834287357, 6109.572329936862, 6138.600990935575, 6154.169187159766, 6243.219597550306, 5269.394019687785, 5684.317881854204, 6066.726997285133, 6189.566730328834, 6265.8120256392385, 4997.900041999213, 6030.125631783367, 6183.628982261079, 6245.281792593819, 6250.718602686438, 6145.740123274718, 6156.476699480505, 6160.722767475474, 6224.875502489925, 6242.843928901723, 4144.647704945113, 4904.166291730415, 4909.729964851967, 4909.754512274372, 4975.502449754996, 4338.3709362142945, 4436.44544431946, 4441.311596702516, 4459.464864216315, 4469.553044695569, 5687.43125687428, 5720.542356611461, 5783.971080144656, 5810.564207684356, 5928.347881733006, 6166.920788861931, 6181.0, 6189.690515474298, 6215.564910456315, 6218.284897236786, 5830.679312637845, 5877.882442351214, 5892.381299963527, 5902.468777810018, 5927.140564618193, 5264.710440925785, 5340.91988620171, 5362.785488580491, 5373.2208829719475, 5399.379071406838, 6333.96833015832, 6336.809895703136, 6344.6827658616885, 6354.6822658867795, 6364.204474440695, 6226.128342032029, 6262.780802671885, 6279.937200627935, 6292.685365731603, 6298.748050077946, 6159.168512250789, 6190.102435146969, 6190.721417536131, 6208.379162083756, 6339.587926784744, 6152.230971128609, 6172.043333283348, 6208.4722798562625, 6218.378162183745, 6226.066090086523, 6237.126802247598, 6257.374262573706, 6294.71673774672, 6305.054241863757, 6309.305976342691, 5873.207117039316, 5960.433758792908, 6037.215162028908, 6118.785842495491, 6136.32500424944, 6042.335343112342, 6098.422650146753, 6115.149072927182, 6153.4769544587425, 6155.815325540241, 5639.379668236573, 5943.316518600416, 5956.583039187389, 5960.5827592068135, 5982.730777115127, 5927.8221653350465, 5975.641461512323, 6010.128531363015, 6089.0, 6140.754369825336, 5929.851753706192, 5973.163757073926, 5993.70031498432, 6001.279846418283, 6040.486558642565], "value": 5647.007396606411, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.9479109902358, 496.0005588738691, 513.5583398277481, 518.4452635679825, 521.2181727408887, 37863.621363786355, 39668.809935701975, 39676.80161599191, 39833.80498585044, 41972.790136049356, 40850.59149408505, 41214.38178427319, 41232.38151427724, 41335.0, 41452.37821432673, 9445.669401570947, 9625.37435066722, 9629.325947183665, 9659.130678238957, 9670.323077384586, 9474.005229450911, 9552.856707149398, 9554.235661147126, 9558.187554057913, 9566.043395660414, 9555.18780903624, 9574.52127393631, 9589.232861371109, 9596.952015239915, 9624.181944534723, 9520.952395238015, 9548.236141108695, 9559.999999999965, 9576.329656924017, 9598.088181622734, 9406.670766523139, 9484.762880927963, 9525.04749525042, 9534.189593884528, 9546.284028697875, 32660.673393266, 38817.44730210788, 39381.01547461308, 39396.0, 39408.408873866916, 3169.4770362890094, 3254.5280934264397, 3303.174206448388, 3374.156460884779, 3450.8102054387, 30333.848330758425, 30763.846180768953, 30810.84594577035, 31215.375692486024, 31659.20851978719, 3220.4686226772556, 3221.114193596756, 3243.497257925025, 3337.0155804037868, 3349.0287816533178, 475186.0, 478181.0, 479915.9999999965, 481750.0, 482098.0, 45532.77233613877, 53019.46980530222, 53053.46946530562, 53097.734511327966, 53230.20154697682, 57310.713446433336, 57629.0, 57640.71179644159, 57850.42149578535, 57863.13205301924, 15759.763603545956, 15828.920855395649, 16020.839791601935, 16025.278862451218, 16054.759178612096, 12292.323922184187, 12447.377631118408, 12476.81284780729, 12504.187227830162, 12516.561920332926, 13697.178169309873, 15205.467808626867, 15280.770788438182, 15811.367545298059, 15932.681346373007, 3179.6343420506473, 6257.499400047986, 6539.574927629689, 6551.672416379162, 6580.309067547934, 876.7764220123828, 966.4587830814767, 997.9600815967425, 1033.3593172233263, 1056.4084112896649, 29693.554596681068, 29789.255268618024, 29864.0, 30248.243793904887, 30257.546136807967, 1025.6666583360438, 1032.1381646325403, 1074.5003573338436, 1113.8440618313443, 1135.6649788312302, 13494.460221591027, 14862.777058344134, 15412.537623871302, 15708.371665133267, 16494.75257871133, 659863.0, 663832.0, 667720.0, 673540.0, 674213.0, 56688.882111484265, 57063.0, 57098.0, 57214.14178787322, 57386.0, 1308.1627758234738, 1338.8058731484075, 1365.0103674835864, 1367.924764137962, 1374.615107769826, 25007.374815629755, 28710.856445717636, 29402.852985734935, 30090.398192036475, 30773.692263077977, 53355.73322133364, 54019.45980540144, 54259.72870135624, 54351.0, 54372.184417234566, 614753.926230366, 618933.0, 622646.8867655633, 622739.0, 623004.0, 26131.869340653175, 26835.0, 27050.72949270482, 40980.79509602433, 41422.0, 44792.328115077646, 45587.86030349268, 45850.31224531568, 45934.31098533458, 46439.53560464352, 37978.73350897071, 38099.61900380961, 38191.427128592535, 38805.6119438802, 39565.60434395734, 37753.0, 37772.43341349827, 37903.0, 38880.80559597184, 38928.0, 35371.29257414786, 36732.632673673994, 37191.44212836864, 37347.81326093461, 37415.81292093522, 26833.329166770985, 29146.125616231548, 30382.84808575943, 30933.381332373676, 33096.338073237916, 22576.0, 22984.885075574515, 25041.74958250394, 25342.0, 26036.183306088435], "value": 19541.237505049612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9107414220587, 373.2162458836443, 374.1245485563779, 384.3466107617048, 395.50759304665695, 18828.623427531442, 19274.421767346983, 19692.90153549232, 19821.603567928632, 19826.603467930632, 19274.51813704658, 19703.60592788147, 19951.501212469695, 19952.30166944157, 20268.189272429085, 4661.65037622178, 5739.253896993385, 6047.637141771508, 6054.212952316193, 6590.538662293641, 6579.703913323912, 6677.332266773333, 6682.766103186389, 6698.799036028927, 6721.596704197739, 5561.555075593963, 5563.36021357543, 5907.6750778707155, 5950.494207992304, 6009.1587177795145, 5443.972780136074, 5944.197533333009, 5979.2824861016525, 6001.9699901500435, 6011.458968692817, 5705.62913410627, 5735.455131762517, 5735.598508104435, 5738.483536481736, 5741.540676745851, 12730.80903786444, 12909.0, 19730.0, 20791.376258712262, 24632.261032169063, 2100.884451355175, 2190.912363505458, 2413.9396515087087, 2466.0382450844186, 2830.3207230264793, 9450.102240287162, 9648.228141748643, 9818.312718109735, 10131.392116473035, 10200.897991020143, 1800.3788692900928, 1818.1818181818235, 1858.6189831084596, 1871.1579789094963, 1886.7830199527093, 123034.0, 128600.35699821534, 129860.35069824685, 129997.0, 131958.3402082993, 9027.909720902839, 11137.610183643696, 11139.665810025712, 11273.605423810128, 11541.538338466535, 11900.404979750978, 13822.37799299014, 14097.647558811112, 14109.647258818406, 14170.85829141716, 6938.479614028968, 8126.796830079295, 8221.380984248444, 8321.6671333146, 8391.706290279812, 7718.459707820399, 7810.414218933603, 8341.749747507585, 8500.957495212484, 8577.828443431097, 3541.29174165168, 4072.6538244249573, 4319.632831209319, 4359.022987932077, 4467.218236808546, 1506.811648543932, 1612.9596760081092, 1888.7261347104593, 1897.0799162406222, 1924.5381108533852, 846.3229416466802, 872.2698300458396, 877.4077497689034, 884.380933346647, 885.4731434796286, 19613.80386196148, 20601.763894166397, 20615.587688246153, 20804.47988800292, 20891.433142514372, 966.7341481092615, 967.3422072990434, 988.7874107067015, 992.6327258914248, 996.4818294486827, 10176.898231017594, 10868.184886133571, 10869.619563315246, 10870.293430926964, 10905.83641245382, 453845.0, 566919.0, 577745.0, 583841.0, 587231.0, 136214.0, 141450.0, 142539.0, 143034.0, 146868.0, 962.8507581324906, 989.6585677941099, 1013.9645112421177, 1016.1413605503337, 1020.6580795433464, 18188.727169092737, 18971.33600323982, 19006.524836879187, 19044.85730856153, 19102.90448547804, 53076.73461632667, 55038.17442738442, 55276.0, 55462.44537554573, 55910.806689499266, 49127.0, 66562.67030653903, 75422.0, 77351.2264877344, 83984.0, 6981.895271571032, 7861.0, 7956.2441568050945, 8022.077461091816, 8072.233137851895, 8095.7166499172245, 12294.89345958868, 12411.193272437262, 12647.051471139517, 12697.682557935756, 10919.962603552649, 10938.295514670004, 11042.779144417227, 11110.055645269918, 11148.219624626197, 10495.632652857113, 10512.316699414514, 10782.406967616856, 11047.668569942914, 11159.44202789841, 10437.703705185151, 10811.405372704578, 11037.558497660004, 11126.554937802397, 11187.832182517432, 7781.805454863674, 7970.322522585413, 7999.520028798291, 8103.797405064921, 8146.714864979697, 10146.949265253626, 10690.518926648165, 10768.246222764332, 11058.944705276423, 11129.610463633733], "value": 9350.30468389505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.2592037339648, 1511.6749898771766, 1601.4635097242424, 1709.1881356355725, 1747.4320845725135, 7844.764657060283, 8105.91894081059, 8348.916510834897, 8905.554722263878, 8923.643054277829, 8375.036870759865, 8650.91349086509, 8664.133586641348, 8666.6100025499, 8748.431351962117, 1948.8538359623014, 2319.072371051576, 2327.650852372141, 2331.6385960176117, 2334.5214231082587, 2299.356180269519, 2328.2433209206993, 2357.882105894707, 2359.162497313455, 2362.3739708977137, 2329.24299602629, 2342.1334106380664, 2350.7766762157567, 2358.481134150484, 2359.304005318435, 2306.953860922789, 2315.8378913476063, 2320.8027317678016, 2326.057946531649, 2333.1250780957057, 1953.5604488990007, 1999.6902029170917, 2303.2744685424036, 2305.72331320241, 2321.7678232176645, 8484.151584841527, 8803.119688031209, 8822.911770882338, 8825.955870220609, 8847.867281990775, 5117.795288188468, 5189.714565698885, 5259.105951988171, 5262.105442074818, 5265.9994601026065, 3294.5387645729616, 3370.140614143402, 3411.795292282446, 3437.295354452331, 3653.725970552193, 1072.860528131338, 1073.538378497246, 1077.735954691098, 1079.22835172851, 1102.3385968418966, 11378.943105284503, 11395.0, 11473.713157171054, 11515.36665483398, 11520.020798232077, 4442.067165895133, 4605.93091103627, 4697.0, 4706.129366067288, 4718.787654555554, 9699.903000970042, 9780.41317520951, 9780.853287200698, 9787.119159275699, 9814.165795907285, 5182.378114626269, 5228.738563071831, 5237.869053273698, 5244.868878277997, 5254.500822421864, 4264.978675106605, 4385.736855788663, 4714.858554243378, 4783.521647835189, 4806.351142595705, 3361.83190840457, 3648.7810731356203, 3804.543454785388, 3917.5103112110987, 3918.431827385013, 1084.707129075161, 1234.2779474007807, 1246.3020708403324, 1254.5295514182183, 1265.702559898423, 720.3840716187689, 743.4052757793744, 809.29591255608, 856.8629019356997, 883.9823203535893, 4855.708657480563, 5127.564157046618, 5283.788648454019, 5898.469137777534, 5931.970340148272, 930.3673502018693, 939.5443210043123, 959.7456673981261, 975.8341082016075, 1013.2451323763696, 3753.5871054184017, 3799.772013679188, 3848.191879705237, 3922.941155882664, 3963.8810835674976, 10276.075153236245, 10710.625128120635, 10737.087347575543, 10740.73148171302, 10794.56821727122, 10682.679519614425, 10705.785884282272, 10708.250422470508, 10718.410487423267, 10730.624428144978, 7615.771526854092, 8093.231143041402, 8231.670733170726, 8245.175482451707, 8270.917290827014, 5763.135529670583, 5905.173275741314, 5950.702464876826, 6010.9699451502465, 6052.364501727256, 9207.585658645243, 9468.384555003902, 9746.512674366395, 9834.508274586098, 9864.358816676893, 9677.806443870943, 9779.070988256104, 9929.553170107218, 9938.0, 10155.187584993035, 7306.3789577884345, 7357.301056399633, 7929.167437419219, 8003.599820009093, 8083.19168083187, 8095.352371810123, 8204.261616454547, 8234.464759790595, 8252.381071419548, 8274.669013239403, 7273.599952002691, 7407.074115735533, 7433.442491813027, 7439.107307122963, 7491.0, 7142.357187853118, 7258.963705181441, 7309.086364204474, 7359.1169059713175, 7382.224866388952, 6871.656417179221, 6938.653067346511, 7002.684879180347, 7006.9649651751415, 7007.159140902921, 4762.261849413347, 4879.170541007966, 4981.078500477423, 4986.252062190701, 5041.773120209673, 4675.4155730533685, 4723.905521889475, 4795.784189711541, 4957.231629097496, 5077.238414237746], "value": 4502.401524506058, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1357404249803, 302.7608189530271, 311.4052160373686, 315.0799664978263, 315.3267773303995, 4563.307648487392, 5353.223782551528, 5538.252335934648, 5557.0, 5746.16680581316, 4694.4601370842365, 5337.7456297769995, 5369.120812710076, 5552.3892371839065, 5559.527440167591, 3468.7745296555768, 4067.8169482373214, 4104.938425923614, 4192.0, 4251.4898212214575, 3684.926301473969, 3924.50943632046, 4276.828926842923, 4279.683245484759, 4296.914061718764, 3309.9834500827583, 4019.859304924328, 4144.254034273829, 4172.0, 4193.979030104845, 3366.0406784066545, 3402.659734026602, 3962.227365663711, 4168.791560421967, 4257.254980378421, 3459.39460594395, 3610.3862343401684, 3626.691731202851, 3626.9274614507826, 3634.27314537091, 4639.30410438437, 5098.056859481007, 5421.268128802601, 5475.342958844924, 5498.230247765276, 4195.91608167838, 4280.336547835091, 4556.334544291561, 4801.759912004386, 4826.517348265145, 5219.982103489783, 5669.348024977139, 5924.437178468039, 5951.821445356646, 6036.245469316335, 3387.8644854205804, 3615.692666123383, 3750.1608767535695, 3930.606939306075, 3940.0, 4984.77568509418, 5059.519345662156, 6020.127081573148, 6230.626162430269, 6230.688465576703, 3854.2676891390547, 4018.1561872006623, 4025.496812898388, 4033.415154802537, 4049.7367671101283, 3591.0, 4036.4348991141264, 4058.4723985881647, 4065.4918135233097, 4069.654079403284, 3815.484909537177, 4775.707660322995, 4779.713217206979, 4782.163121453732, 4822.252550854553, 5377.623566350396, 5930.28836539618, 5975.223220981245, 6011.549133814981, 6013.7895173669585, 1039.6309310194922, 1295.6307452376216, 1336.8395792504962, 1341.9798703019462, 1391.9560329752685, 865.2818160926416, 880.366136381804, 900.6127365233012, 922.6678395777515, 925.4956048953202, 4975.502449754996, 5283.0, 5436.885438485101, 5520.585956053312, 5563.553476096163, 4594.748573199108, 5697.515711164515, 5958.880822383528, 6014.789482368096, 6049.969750151221, 5050.747462626854, 5065.746712664352, 5174.680456483573, 5240.554552863049, 5242.217646000378, 2981.567672687448, 3231.2228274448958, 3250.8374581271314, 3251.512273159045, 3267.738580913569, 5580.2745643066955, 6280.5603607747935, 6290.465310448663, 6309.842253943688, 6410.583312084699, 5568.248286481273, 5737.598368114275, 5871.706414679249, 6241.875162496724, 6306.49548036156, 6075.422834830684, 6362.840928976812, 6381.6285844195945, 6387.425131738073, 6413.839654008687, 5244.816431424882, 5776.989026920188, 5959.757297636822, 6049.606775559574, 6167.722452489559, 5962.956482615612, 5992.67040312787, 6064.969675151596, 6078.027515597483, 6104.481119104926, 5564.57616195134, 5962.433568810956, 6010.459058684739, 6382.3617638237665, 6382.6170429774365, 3394.7284217262068, 3866.69066474687, 4015.377616469452, 4028.113814960704, 4037.2329257442166, 5943.91084133747, 6171.691415429121, 6201.3178550358525, 6232.439080482778, 6242.968785156045, 5145.945081258408, 5320.414754377093, 5798.275215598051, 6025.216721826135, 6042.939570604238, 5232.11054120808, 5366.946330536801, 6025.849353766191, 6029.487493563096, 6086.482648974887, 4885.5358740919555, 5232.5552328052545, 5656.6888821115235, 5714.771324165325, 5867.6772777497645, 4408.669349798842, 5021.824236151717, 5120.590352771844, 5820.621659592113, 6109.541784366102, 4474.463064432289, 5145.845624631267, 5427.236148251755, 5859.970700146472, 5898.546597318997], "value": 4224.312781606643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.2599192871699, 722.81568200109, 756.4100001998443, 779.8596252674516, 795.634008356156, 14750.852491475081, 15971.520854374387, 15998.440054598092, 16057.999999999985, 16106.91946540267, 14189.361478733455, 14312.642183945407, 14337.713245735105, 14364.784528232085, 14365.281735913215, 645.0743183531623, 672.3948446398232, 798.8601994650942, 800.2437696376926, 824.9422540422173, 791.9168487308837, 822.7408366364606, 823.1644880446352, 824.9587520623945, 825.1748251748252, 872.6422166911567, 880.2341962492641, 881.352206128495, 881.722257488889, 882.3779235638891, 699.3321378083917, 731.381982225019, 759.9886001709979, 768.9926196682364, 878.0648609231148, 547.2721280696663, 631.6746875359194, 649.4966401039185, 654.8755736410067, 655.3872129558878, 12969.87030129696, 12977.480900764052, 12995.675108122277, 13012.739745205043, 13013.21920684762, 14236.217008064552, 14309.642258943506, 14341.928290358586, 14356.282185890665, 14375.209363485004, 11740.647780566596, 11895.0, 11947.402629868471, 11967.0, 12002.63992080239, 3705.814709264526, 3761.6050314716836, 3769.0, 3881.9805900970596, 3894.824732887027, 116371.20963000537, 118534.40732796367, 118841.40579297135, 119501.8049819508, 119858.99999999913, 10447.738806529898, 11053.889461105286, 11088.778224435466, 11216.775664486664, 11271.887281127249, 22509.212177573707, 22545.32364029082, 22592.887035564716, 22598.661020084714, 22605.773942260366, 7759.456838021284, 7780.260875216845, 7901.604919754104, 8103.635336409876, 8104.27061564462, 4081.5918408158946, 4114.465119534441, 4192.664586833107, 4197.349410841324, 4328.04782947751, 3565.4651802229873, 3663.120850995742, 3679.0802299425145, 3689.4834723138783, 3693.4459831025024, 552.2351543112818, 555.2781384200523, 623.8627501949563, 652.1326635574675, 652.729117416267, 634.511426201822, 650.9641969691712, 656.5535435903536, 658.8023592922104, 667.2293501006345, 7888.1323054463965, 8748.1251874812, 9110.954445227731, 9304.441733496013, 9463.90536094644, 634.2737565487491, 643.9001954697029, 649.6913965866175, 656.7537173559915, 658.1476987301456, 4141.8964525886495, 4177.874663760092, 4363.672724545671, 4390.846320378771, 4597.931031034537, 166178.0, 167528.0, 167600.0, 170490.0, 172575.0, 137704.0, 139576.0, 139892.0, 141397.0, 143578.28210859088, 123916.07552602797, 124491.0, 125276.37361813315, 130306.34846825895, 130327.34836325947, 7549.0, 8728.0, 8988.46069235848, 8995.775105622412, 9200.6779762708, 54319.45680543144, 69381.65309173422, 69891.65054174696, 69961.65019174872, 69964.6501767488, 104489.0, 105392.47303763739, 105559.0, 105765.0, 105982.0, 11428.028617567268, 11818.704532386759, 11927.165098443025, 11997.700057498283, 12389.814152787536, 12733.61799146027, 12803.03977201695, 12979.091463597457, 13385.0, 13482.797758033441, 10129.442880641636, 11387.715307117389, 11854.94072529632, 11903.047756179312, 12224.0, 11930.463129159036, 12020.158588898694, 12214.633560993185, 12495.750084998432, 12543.749125017266, 12033.398330083635, 12062.879371206176, 12177.817332740193, 12296.077794165294, 12447.0, 10306.12397946183, 10378.584856605954, 10515.631952881613, 10563.524641391003, 10665.840012399665, 8239.464434811718, 8405.579721014046, 9518.476483793182, 10179.898201017895, 10504.159667226451], "value": 7647.709129580041, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 121.0, 116.0, 98.0, 175.0, 174.0, 129.0, 117.0, 116.0], "value": 127.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 115.0, 154.0, 115.0, 121.0, 118.0, 141.0, 157.0, 119.0], "value": 130.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 215.0, 265.0, 281.0, 198.0, 257.0, 222.0, 198.0, 198.0, 206.0], "value": 225.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 61.0, 52.0, 96.0, 80.0, 86.0, 49.0, 74.0, 107.0, 85.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 74.0, 69.0, 70.0, 87.0, 72.0, 70.0, 89.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 86.0, 90.0, 85.0, 88.0, 85.0, 92.0, 114.0, 89.0, 88.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 96.0, 96.0, 95.0, 131.0, 151.0, 95.0, 122.0, 92.0, 146.0], "value": 117.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 88.0, 153.0, 151.0, 119.0, 101.0, 139.0, 147.0, 147.0, 131.0], "value": 132.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 54.0, 57.0, 56.0, 57.0, 57.0, 57.0, 55.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 97.0, 67.0, 75.0, 73.0, 69.0, 70.0, 73.0, 73.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 106.0, 105.0, 89.0, 90.0, 105.0, 116.0, 111.0, 105.0], "value": 100.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 163.0, 154.0, 142.0, 152.0, 148.0, 183.0, 169.0, 225.0, 146.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 175.0, 173.0, 173.0, 176.0, 177.0, 177.0, 180.0, 177.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 72.0, 72.0, 70.0, 71.0, 72.0, 71.0, 67.0, 75.0], "value": 71.3, "unit": "score"}]}]} 05:36:12 INFO - Return code: 0 05:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:12 ERROR - # TBPL SUCCESS # 05:36:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:12 INFO - 2016-10-11 05:36:12.457 screenresolution[1969:18877] starting screenresolution argv=screenresolution get 05:36:12 INFO - 2016-10-11 05:36:12.461 screenresolution[1969:18877] Display 0: 1600x1200x32@60 05:36:12 INFO - 2016-10-11 05:36:12.467 screenresolution[1970:18880] starting screenresolution argv=screenresolution list 05:36:12 INFO - Available Modes on Display 0 05:36:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:12 INFO - Intel Iris: 05:36:12 INFO - Chipset Model: Intel Iris 05:36:12 INFO - Type: GPU 05:36:12 INFO - Bus: Built-In 05:36:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:12 INFO - Vendor: Intel (0x8086) 05:36:12 INFO - Device ID: 0x0a2e 05:36:12 INFO - Revision ID: 0x0009 05:36:12 INFO - Displays: 05:36:12 INFO - Display: 05:36:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:12 INFO - Display Serial Number: 1600x1200 60 05:36:12 INFO - Main Display: Yes 05:36:12 INFO - Mirror: Off 05:36:12 INFO - Online: Yes 05:36:12 INFO - Rotation: Supported 05:36:12 INFO - Return code: 0 05:36:12 INFO - Running post-action listener: _resource_record_post_action 05:36:12 INFO - [mozharness: 2016-10-11 12:36:12.705180Z] Finished run-tests step (success) 05:36:12 INFO - Running post-run listener: _resource_record_post_run 05:36:12 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 851968; Write bytes: 712093184; Read time: 9; Write time: 1965 05:36:12 INFO - TinderboxPrint: CPU usage
54.3% 05:36:12 INFO - TinderboxPrint: I/O read bytes / time
851,968 / 9 05:36:12 INFO - TinderboxPrint: I/O write bytes / time
712,093,184 / 1,965 05:36:12 INFO - TinderboxPrint: CPU idle
2,214.3 (45.7%) 05:36:12 INFO - TinderboxPrint: CPU system
979.4 (20.2%) 05:36:12 INFO - TinderboxPrint: CPU user
1,656.0 (34.1%) 05:36:12 INFO - TinderboxPrint: Swap in / out
407,453,696 / 0 05:36:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399258112; Write bytes: 394381312; Read time: 29591; Write time: 743 05:36:12 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 851968; Write bytes: 300762624; Read time: 9; Write time: 1183 05:36:13 INFO - Running post-run listener: _upload_blobber_files 05:36:13 INFO - Blob upload gear active. 05:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:13 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 05:36:13 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'] 05:36:13 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 05:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:14 INFO - (blobuploader) - INFO - Done attempting. 05:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:15 INFO - (blobuploader) - INFO - Done attempting. 05:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:18 INFO - (blobuploader) - INFO - Done attempting. 05:36:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:18 INFO - Return code: 0 05:36:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d164dc417114a0c55b17bd1309bc29907e83aef44520a39b35532c3ab475335baa4ac94a0590d26204001dc4f7c51013c15089842e9a936d8edac62599c48ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e259b1e8db6be67882b0adb72b2c1aaf1f2c2452d2651df6315a981e16f6f9b9583448263603482049a415799cbc52ea557c5a9fbacf42690226e30605b85f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb96132ede89159a33318c7f151413ce805f46c0f0d0184e157c334614f1ad883b27a553598e1e6fcf2cd8798a6629ff289b2187e3226b0a5d9d6f9c43e63be"} 05:36:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:18 INFO - Contents: 05:36:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d164dc417114a0c55b17bd1309bc29907e83aef44520a39b35532c3ab475335baa4ac94a0590d26204001dc4f7c51013c15089842e9a936d8edac62599c48ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e259b1e8db6be67882b0adb72b2c1aaf1f2c2452d2651df6315a981e16f6f9b9583448263603482049a415799cbc52ea557c5a9fbacf42690226e30605b85f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb96132ede89159a33318c7f151413ce805f46c0f0d0184e157c334614f1ad883b27a553598e1e6fcf2cd8798a6629ff289b2187e3226b0a5d9d6f9c43e63be"} 05:36:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:18 INFO - Copying logs to upload dir... 05:36:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.544258 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 05:36:18.259610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:36:18.267472) ========= 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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/2d164dc417114a0c55b17bd1309bc29907e83aef44520a39b35532c3ab475335baa4ac94a0590d26204001dc4f7c51013c15089842e9a936d8edac62599c48ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e259b1e8db6be67882b0adb72b2c1aaf1f2c2452d2651df6315a981e16f6f9b9583448263603482049a415799cbc52ea557c5a9fbacf42690226e30605b85f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb96132ede89159a33318c7f151413ce805f46c0f0d0184e157c334614f1ad883b27a553598e1e6fcf2cd8798a6629ff289b2187e3226b0a5d9d6f9c43e63be"} build_url:https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/fhVRDQ_ZQYyzSl20PjPyhg/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/2d164dc417114a0c55b17bd1309bc29907e83aef44520a39b35532c3ab475335baa4ac94a0590d26204001dc4f7c51013c15089842e9a936d8edac62599c48ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08e259b1e8db6be67882b0adb72b2c1aaf1f2c2452d2651df6315a981e16f6f9b9583448263603482049a415799cbc52ea557c5a9fbacf42690226e30605b85f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb96132ede89159a33318c7f151413ce805f46c0f0d0184e157c334614f1ad883b27a553598e1e6fcf2cd8798a6629ff289b2187e3226b0a5d9d6f9c43e63be"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:36:18.306949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-11 05:36:18.307330) ========= 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.rhUt7S1emQ/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.QvVs9WG7kS/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005287 ========= master_lag: 3.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-11 05:36:21.552838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:36:21.557317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:36:21.558093) ========= ========= Total master_lag: 3.44 =========