builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0277 starttime: 1476526104.29 results: success (0) buildid: 20161015020935 builduid: 4d78f8bbb5ce420994b1c7aecc00f08f revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:24.288476) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:24.288955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:24.289240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:24.562282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:24.562908) ========= 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.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-15 03:08:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.20M=0.001s 2016-10-15 03:08:25 (8.20 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.447287 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:25.051871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:25.052148) ========= 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.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.020205 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:25.109281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-15 03:08:25.109590) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a1297e90c5981dea1449019480328aafff0cbd5 --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 2a1297e90c5981dea1449019480328aafff0cbd5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-15 03:08:25,196 truncating revision to first 12 chars 2016-10-15 03:08:25,196 Setting DEBUG logging. 2016-10-15 03:08:25,196 attempt 1/10 2016-10-15 03:08:25,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a1297e90c59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 03:08:26,026 unpacking tar archive at: mozilla-central-2a1297e90c59/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094920 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-15 03:08:26.232218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:26.232540) ========= script_repo_revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:26.232986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:26.233257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:08:26.252738) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-15 03:08:26.253056) ========= /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.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:08:26 INFO - MultiFileLogger online at 20161015 03:08:26 in /builds/slave/test 03:08:26 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 03:08:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:26 INFO - {'append_to_log': False, 03:08:26 INFO - 'base_work_dir': '/builds/slave/test', 03:08:26 INFO - 'blob_upload_branch': 'Firefox', 03:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:26 INFO - 'branch': 'Firefox', 03:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:26 INFO - 'config_files': ('talos/mac_config.py',), 03:08:26 INFO - 'default_actions': ('clobber', 03:08:26 INFO - 'read-buildbot-config', 03:08:26 INFO - 'download-and-extract', 03:08:26 INFO - 'populate-webroot', 03:08:26 INFO - 'create-virtualenv', 03:08:26 INFO - 'install', 03:08:26 INFO - 'run-tests'), 03:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:26 INFO - 'download_minidump_stackwalk': True, 03:08:26 INFO - 'download_symbols': 'ondemand', 03:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:26 INFO - 'installer_path': 'installer.exe', 03:08:26 INFO - 'log_level': 'info', 03:08:26 INFO - 'log_name': 'talos', 03:08:26 INFO - 'log_to_console': True, 03:08:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:08:26 INFO - 'opt_config_files': (), 03:08:26 INFO - 'pip_index': False, 03:08:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:26 INFO - 'cmd': ('bash', 03:08:26 INFO - '-c', 03:08:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:26 INFO - 'enabled': True, 03:08:26 INFO - 'halt_on_failure': False, 03:08:26 INFO - 'name': 'check_screen_resolution'},), 03:08:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:08:26 INFO - 'cmd': ('bash', 03:08:26 INFO - '-c', 03:08:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:08:26 INFO - 'enabled': True, 03:08:26 INFO - 'halt_on_failure': False, 03:08:26 INFO - 'name': 'check_screen_resolution'},), 03:08:26 INFO - 'run_cmd_checks_enabled': True, 03:08:26 INFO - 'sps_profile': False, 03:08:26 INFO - 'sps_profile_interval': 0, 03:08:26 INFO - 'suite': 'dromaeojs-e10s', 03:08:26 INFO - 'system_bits': '32', 03:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:26 INFO - 'title': 't-yosemite-r7-0277', 03:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:26 INFO - 'use_talos_json': True, 03:08:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:26 INFO - 'work_dir': 'build'} 03:08:26 INFO - [mozharness: 2016-10-15 10:08:26.453613Z] Running clobber step. 03:08:26 INFO - Running pre-action listener: _resource_record_pre_action 03:08:26 INFO - Running main action method: clobber 03:08:26 INFO - rmtree: /builds/slave/test/build 03:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:28 INFO - Running post-action listener: _resource_record_post_action 03:08:28 INFO - [mozharness: 2016-10-15 10:08:28.616003Z] Finished clobber step (success) 03:08:28 INFO - [mozharness: 2016-10-15 10:08:28.616154Z] Running read-buildbot-config step. 03:08:28 INFO - Running pre-action listener: _resource_record_pre_action 03:08:28 INFO - Running main action method: read_buildbot_config 03:08:28 INFO - Using buildbot properties: 03:08:28 INFO - { 03:08:28 INFO - "project": "", 03:08:28 INFO - "product": "firefox", 03:08:28 INFO - "script_repo_revision": "production", 03:08:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:08:28 INFO - "repository": "", 03:08:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:08:28 INFO - "buildid": "20161015020935", 03:08:28 INFO - "pgo_build": "False", 03:08:28 INFO - "basedir": "/builds/slave/test", 03:08:28 INFO - "buildnumber": 76, 03:08:28 INFO - "slavename": "t-yosemite-r7-0277", 03:08:28 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:08:28 INFO - "platform": "yosemite_r7", 03:08:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:08:28 INFO - "branch": "mozilla-central", 03:08:28 INFO - "repo_path": "mozilla-central", 03:08:28 INFO - "revision": "2a1297e90c5981dea1449019480328aafff0cbd5", 03:08:28 INFO - "stage_platform": "macosx64", 03:08:28 INFO - "builduid": "4d78f8bbb5ce420994b1c7aecc00f08f", 03:08:28 INFO - "slavebuilddir": "test" 03:08:28 INFO - } 03:08:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:08:28 INFO - Running post-action listener: _resource_record_post_action 03:08:28 INFO - [mozharness: 2016-10-15 10:08:28.619574Z] Finished read-buildbot-config step (success) 03:08:28 INFO - [mozharness: 2016-10-15 10:08:28.619680Z] Running download-and-extract step. 03:08:28 INFO - Running pre-action listener: _resource_record_pre_action 03:08:28 INFO - Running main action method: download_and_extract 03:08:28 INFO - mkdir: /builds/slave/test/build/tests 03:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:28 INFO - trying https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:08:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/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 03:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/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 03:08:30 INFO - Downloaded 1199 bytes. 03:08:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:08:30 INFO - Using the following test package requirements: 03:08:30 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:08:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:08:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:08:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'jsshell-mac.zip'], 03:08:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:08:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:08:30 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:08:30 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:08:30 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:08:30 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:08:30 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:08:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:08:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:08:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:08:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:08:30 INFO - Http code: 200 03:08:30 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 03:08:30 INFO - x-amz-cf-id: 4O7qnm2-SWDMQlegHkFGOUo4VU_tM3zRN6a_7YhNnCqdFrOy9vH7cw== 03:08:30 INFO - x-amz-version-id: rGQScD63rjq8KAC2jF9WBheXc4nt0DIw 03:08:31 INFO - Expected file size: 16516681 03:08:31 INFO - Obtained file size: 16516681 03:08:37 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 03:08:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:08:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:08:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:08:38 INFO - Http code: 200 03:08:38 INFO - via: 1.1 30bb04916f91d64c600e15c15000042d.cloudfront.net (CloudFront) 03:08:38 INFO - x-amz-cf-id: I5taUFDXba0vchS0y7vNnUGIyymmPvAKTz9WFwR-Nir76UFOSKhS0A== 03:08:38 INFO - x-amz-version-id: rGQScD63rjq8KAC2jF9WBheXc4nt0DIw 03:08:38 INFO - Expected file size: 16516681 03:08:38 INFO - Obtained file size: 16516681 03:08:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:08:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:08:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:08:45 INFO - Http code: 200 03:08:45 INFO - via: 1.1 ff09df097f823b2834408d17e9779d62.cloudfront.net (CloudFront) 03:08:45 INFO - x-amz-cf-id: eVJuniuvK6pcSWqfk9k91tIg7CMlnVQgfjrfdby3ZEZYEbMR0b_WwA== 03:08:45 INFO - x-amz-version-id: mAUXNH_1kjZGACqbZiNcSn4tTCLrbV8u 03:08:45 INFO - Expected file size: 14409028 03:08:45 INFO - Obtained file size: 14409028 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:08:46 INFO - trying https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:08:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/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 03:08:49 INFO - Downloaded 111959938 bytes. 03:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:08:49 INFO - mkdir: /builds/slave/test/properties 03:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:08:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:08:49 INFO - Contents: 03:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:08:49 INFO - Running post-action listener: _resource_record_post_action 03:08:49 INFO - Running post-action listener: set_extra_try_arguments 03:08:49 INFO - [mozharness: 2016-10-15 10:08:49.733408Z] Finished download-and-extract step (success) 03:08:49 INFO - [mozharness: 2016-10-15 10:08:49.733526Z] Running populate-webroot step. 03:08:49 INFO - Running pre-action listener: _resource_record_pre_action 03:08:49 INFO - Running main action method: populate_webroot 03:08:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:49 INFO - '--tppagecycles', 03:08:49 INFO - '7'], 03:08:49 INFO - 'tests': ['tsvgm']}}, 03:08:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:08:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:08:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:08:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['damp', 'tps']}, 03:08:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'tests': ['damp', 'tps']}, 03:08:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['dromaeo_dom']}, 03:08:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['basic_compositor_video']}, 03:08:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:08:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'other-e10s': {'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['a11yr', 03:08:49 INFO - 'ts_paint', 03:08:49 INFO - 'tpaint', 03:08:49 INFO - 'sessionrestore', 03:08:49 INFO - 'sessionrestore_no_auto_restore', 03:08:49 INFO - 'tabpaint']}, 03:08:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['tsvgx', 03:08:49 INFO - 'tsvgr_opacity', 03:08:49 INFO - 'tart', 03:08:49 INFO - 'tscrollx', 03:08:49 INFO - 'cart']}, 03:08:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:08:49 INFO - 'tsvgr_opacity', 03:08:49 INFO - 'tart', 03:08:49 INFO - 'tscrollx', 03:08:49 INFO - 'cart']}, 03:08:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'talos_options': ['--disable-e10s'], 03:08:49 INFO - 'tests': ['tp5o']}, 03:08:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'tests': ['tp5o']}, 03:08:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'talos_options': ['--disable-e10s', 03:08:49 INFO - '--xperf_path', 03:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:49 INFO - 'tests': ['tp5n']}, 03:08:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:49 INFO - 'talos_options': ['--xperf_path', 03:08:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:49 INFO - 'tests': ['tp5n']}}, 03:08:49 INFO - 'talos.zip': {'path': '', 03:08:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:49 INFO - Running post-action listener: _resource_record_post_action 03:08:49 INFO - [mozharness: 2016-10-15 10:08:49.752285Z] Finished populate-webroot step (success) 03:08:49 INFO - [mozharness: 2016-10-15 10:08:49.752422Z] Running create-virtualenv step. 03:08:49 INFO - Running pre-action listener: _resource_record_pre_action 03:08:49 INFO - Running main action method: create_virtualenv 03:08:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:08:49 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 03:08:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:08:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:49 INFO - Using real prefix '/tools/python27' 03:08:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:08:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:53 INFO - Installing pip.................done. 03:08:53 INFO - Return code: 0 03:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:08:53 INFO - Reading from file tmpfile_stdout 03:08:53 INFO - Output received: 03:08:53 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) 03:08:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:53 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:08:53 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 03:08:53 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 03:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:53 INFO - 'HOME': '/Users/cltbld', 03:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:53 INFO - 'LOGNAME': 'cltbld', 03:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:53 INFO - 'MOZ_NO_REMOTE': '1', 03:08:53 INFO - 'NO_EM_RESTART': '1', 03:08:53 INFO - 'PAGER': '/bin/cat', 03:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:53 INFO - 'PWD': '/builds/slave/test', 03:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:53 INFO - 'SHELL': '/bin/bash', 03:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:08:53 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:53 INFO - 'USER': 'cltbld', 03:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:53 INFO - 'XPC_FLAGS': '0x0', 03:08:53 INFO - 'XPC_SERVICE_NAME': '0', 03:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:53 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 03:08:53 INFO - Cleaning up... 03:08:53 INFO - Return code: 0 03:08:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:53 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:08:53 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 03:08:53 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 03:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:53 INFO - 'HOME': '/Users/cltbld', 03:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:53 INFO - 'LOGNAME': 'cltbld', 03:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:53 INFO - 'MOZ_NO_REMOTE': '1', 03:08:53 INFO - 'NO_EM_RESTART': '1', 03:08:53 INFO - 'PAGER': '/bin/cat', 03:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:53 INFO - 'PWD': '/builds/slave/test', 03:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:53 INFO - 'SHELL': '/bin/bash', 03:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:08:53 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:53 INFO - 'USER': 'cltbld', 03:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:53 INFO - 'XPC_FLAGS': '0x0', 03:08:53 INFO - 'XPC_SERVICE_NAME': '0', 03:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:54 INFO - Downloading/unpacking psutil>=3.1.1 03:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:57 INFO - Installing collected packages: psutil 03:08:57 INFO - Running setup.py install for psutil 03:08:58 INFO - building 'psutil._psutil_osx' extension 03:08:58 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 03:08:58 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 03:08:58 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 03:08:58 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 03:08:58 INFO - building 'psutil._psutil_posix' extension 03:08:58 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 03:08:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:08:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:08:58 INFO - ^ 03:08:58 INFO - 1 warning generated. 03:08:58 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 03:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:58 INFO - Successfully installed psutil 03:08:58 INFO - Cleaning up... 03:08:58 INFO - Return code: 0 03:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:08:58 INFO - 'HOME': '/Users/cltbld', 03:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:08:58 INFO - 'LOGNAME': 'cltbld', 03:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:58 INFO - 'MOZ_NO_REMOTE': '1', 03:08:58 INFO - 'NO_EM_RESTART': '1', 03:08:58 INFO - 'PAGER': '/bin/cat', 03:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:58 INFO - 'PWD': '/builds/slave/test', 03:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:08:58 INFO - 'SHELL': '/bin/bash', 03:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:08:58 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:08:58 INFO - 'USER': 'cltbld', 03:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:58 INFO - 'XPC_FLAGS': '0x0', 03:08:58 INFO - 'XPC_SERVICE_NAME': '0', 03:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:09:01 INFO - Installing collected packages: mozsystemmonitor 03:09:01 INFO - Running setup.py install for mozsystemmonitor 03:09:01 INFO - Successfully installed mozsystemmonitor 03:09:01 INFO - Cleaning up... 03:09:01 INFO - Return code: 0 03:09:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:09:01 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')]} 03:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 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')]} 03:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:01 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 03:09:01 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 03:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:01 INFO - 'HOME': '/Users/cltbld', 03:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:01 INFO - 'LOGNAME': 'cltbld', 03:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:01 INFO - 'MOZ_NO_REMOTE': '1', 03:09:01 INFO - 'NO_EM_RESTART': '1', 03:09:01 INFO - 'PAGER': '/bin/cat', 03:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:01 INFO - 'PWD': '/builds/slave/test', 03:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:01 INFO - 'SHELL': '/bin/bash', 03:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:01 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:01 INFO - 'USER': 'cltbld', 03:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:01 INFO - 'XPC_FLAGS': '0x0', 03:09:01 INFO - 'XPC_SERVICE_NAME': '0', 03:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:09:04 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 03:09:04 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 03:09:04 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 03:09:04 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 03:09:04 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 03:09:04 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 03:09:05 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:05 INFO - warning: no files found matching '*.txt' 03:09:05 INFO - no previously-included directories found matching 'build' 03:09:05 INFO - no previously-included directories found matching 'dist' 03:09:05 INFO - no previously-included directories found matching '.git*' 03:09:05 INFO - Installing collected packages: jsonschema, functools32 03:09:05 INFO - Running setup.py install for functools32 03:09:05 INFO - warning: no files found matching '*.txt' 03:09:05 INFO - no previously-included directories found matching 'build' 03:09:05 INFO - no previously-included directories found matching 'dist' 03:09:05 INFO - no previously-included directories found matching '.git*' 03:09:05 INFO - Successfully installed jsonschema functools32 03:09:05 INFO - Cleaning up... 03:09:05 INFO - Return code: 0 03:09:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:05 INFO - 'HOME': '/Users/cltbld', 03:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:05 INFO - 'LOGNAME': 'cltbld', 03:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:05 INFO - 'MOZ_NO_REMOTE': '1', 03:09:05 INFO - 'NO_EM_RESTART': '1', 03:09:05 INFO - 'PAGER': '/bin/cat', 03:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:05 INFO - 'PWD': '/builds/slave/test', 03:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:05 INFO - 'SHELL': '/bin/bash', 03:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:05 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:05 INFO - 'USER': 'cltbld', 03:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:05 INFO - 'XPC_FLAGS': '0x0', 03:09:05 INFO - 'XPC_SERVICE_NAME': '0', 03:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:09:05 INFO - Cleaning up... 03:09:05 INFO - Return code: 0 03:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:05 INFO - 'HOME': '/Users/cltbld', 03:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:05 INFO - 'LOGNAME': 'cltbld', 03:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:05 INFO - 'MOZ_NO_REMOTE': '1', 03:09:05 INFO - 'NO_EM_RESTART': '1', 03:09:05 INFO - 'PAGER': '/bin/cat', 03:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:05 INFO - 'PWD': '/builds/slave/test', 03:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:05 INFO - 'SHELL': '/bin/bash', 03:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:05 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:05 INFO - 'USER': 'cltbld', 03:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:05 INFO - 'XPC_FLAGS': '0x0', 03:09:05 INFO - 'XPC_SERVICE_NAME': '0', 03:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:06 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 03:09:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:09:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:09:09 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 03:09:09 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 03:09:09 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 03:09:09 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 03:09:09 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 03:09:09 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 03:09:09 INFO - Downloading docopt-0.6.1.tar.gz 03:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:09:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:09:09 INFO - Running setup.py install for blobuploader 03:09:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:09:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:09:09 INFO - Running setup.py install for requests 03:09:10 INFO - Running setup.py install for docopt 03:09:10 INFO - Successfully installed blobuploader requests docopt 03:09:10 INFO - Cleaning up... 03:09:10 INFO - Return code: 0 03:09:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:10 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:10 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 03:09:10 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 03:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:10 INFO - 'HOME': '/Users/cltbld', 03:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:10 INFO - 'LOGNAME': 'cltbld', 03:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:10 INFO - 'MOZ_NO_REMOTE': '1', 03:09:10 INFO - 'NO_EM_RESTART': '1', 03:09:10 INFO - 'PAGER': '/bin/cat', 03:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:10 INFO - 'PWD': '/builds/slave/test', 03:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:10 INFO - 'SHELL': '/bin/bash', 03:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:10 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:10 INFO - 'USER': 'cltbld', 03:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:10 INFO - 'XPC_FLAGS': '0x0', 03:09:10 INFO - 'XPC_SERVICE_NAME': '0', 03:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:10 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Dvcsql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-a6lHRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ad7C1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-dx4VIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4zLb1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-miH8Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Ww2JZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pYBFJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NjxCNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-S1zLKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-G6deNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-P5cB4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6DlR35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pYcsf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-dYVCVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-lE6EcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-hDiMtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:09:12 INFO - Running setup.py install for manifestparser 03:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:09:12 INFO - Running setup.py install for mozcrash 03:09:13 INFO - Running setup.py install for mozdebug 03:09:13 INFO - Running setup.py install for mozdevice 03:09:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Running setup.py install for mozfile 03:09:13 INFO - Running setup.py install for mozhttpd 03:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Running setup.py install for mozinfo 03:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Running setup.py install for mozInstall 03:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:09:13 INFO - Running setup.py install for mozleak 03:09:14 INFO - Running setup.py install for mozlog 03:09:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Running setup.py install for moznetwork 03:09:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Running setup.py install for mozprocess 03:09:14 INFO - Running setup.py install for mozprofile 03:09:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Running setup.py install for mozrunner 03:09:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:09:14 INFO - Running setup.py install for mozscreenshot 03:09:15 INFO - Running setup.py install for moztest 03:09:15 INFO - Running setup.py install for mozversion 03:09:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:09:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:09:15 INFO - Cleaning up... 03:09:15 INFO - Return code: 0 03:09:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:15 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:15 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 03:09:15 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 03:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:15 INFO - 'HOME': '/Users/cltbld', 03:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:15 INFO - 'LOGNAME': 'cltbld', 03:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:15 INFO - 'MOZ_NO_REMOTE': '1', 03:09:15 INFO - 'NO_EM_RESTART': '1', 03:09:15 INFO - 'PAGER': '/bin/cat', 03:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:15 INFO - 'PWD': '/builds/slave/test', 03:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:15 INFO - 'SHELL': '/bin/bash', 03:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:15 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:15 INFO - 'USER': 'cltbld', 03:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:15 INFO - 'XPC_FLAGS': '0x0', 03:09:15 INFO - 'XPC_SERVICE_NAME': '0', 03:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:09:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-tcxcUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:09:15 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)) 03:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:09:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3OQY8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:09:15 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)) 03:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:09:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-JbjshE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:09:15 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)) 03:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:09:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-bTVgOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wKYX6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HgiIpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-YoWglh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sIy65w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-hqqOM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NvIdOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NBAsn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sLsgMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:09:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Pvjxoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:09:16 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)) 03:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:09:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-H11viG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:09:17 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)) 03:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-H1HBaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:09:17 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)) 03:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:09:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-26PSqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:09:17 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)) 03:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:09:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jBYYk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 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)) 03:09:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:09:17 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 03:09:17 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 03:09:17 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 03:09:17 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 03:09:17 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 03:09:17 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 03:09:19 INFO - Downloading blessings-1.6.tar.gz 03:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:19 INFO - Installing collected packages: blessings 03:09:19 INFO - Running setup.py install for blessings 03:09:20 INFO - Successfully installed blessings 03:09:20 INFO - Cleaning up... 03:09:20 INFO - Return code: 0 03:09:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:20 INFO - Reading from file tmpfile_stdout 03:09:20 INFO - Current package versions: 03:09:20 INFO - blessings == 1.6 03:09:20 INFO - blobuploader == 1.2.4 03:09:20 INFO - docopt == 0.6.1 03:09:20 INFO - functools32 == 3.2.3-2 03:09:20 INFO - jsonschema == 2.5.1 03:09:20 INFO - manifestparser == 1.1 03:09:20 INFO - mozInstall == 1.12 03:09:20 INFO - mozcrash == 0.17 03:09:20 INFO - mozdebug == 0.1 03:09:20 INFO - mozdevice == 0.48 03:09:20 INFO - mozfile == 1.2 03:09:20 INFO - mozhttpd == 0.7 03:09:20 INFO - mozinfo == 0.9 03:09:20 INFO - mozleak == 0.1 03:09:20 INFO - mozlog == 3.4 03:09:20 INFO - moznetwork == 0.27 03:09:20 INFO - mozprocess == 0.23 03:09:20 INFO - mozprofile == 0.28 03:09:20 INFO - mozrunner == 6.12 03:09:20 INFO - mozscreenshot == 0.1 03:09:20 INFO - mozsystemmonitor == 0.3 03:09:20 INFO - moztest == 0.7 03:09:20 INFO - mozversion == 1.4 03:09:20 INFO - psutil == 3.1.1 03:09:20 INFO - requests == 1.2.3 03:09:20 INFO - wsgiref == 0.1.2 03:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:09:20 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')]} 03:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:20 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')]} 03:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:20 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:20 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 03:09:20 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 03:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:20 INFO - 'HOME': '/Users/cltbld', 03:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:20 INFO - 'LOGNAME': 'cltbld', 03:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:20 INFO - 'MOZ_NO_REMOTE': '1', 03:09:20 INFO - 'NO_EM_RESTART': '1', 03:09:20 INFO - 'PAGER': '/bin/cat', 03:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:20 INFO - 'PWD': '/builds/slave/test', 03:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:20 INFO - 'SHELL': '/bin/bash', 03:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:20 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:20 INFO - 'USER': 'cltbld', 03:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:20 INFO - 'XPC_FLAGS': '0x0', 03:09:20 INFO - 'XPC_SERVICE_NAME': '0', 03:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 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)) 03:09:20 INFO - Cleaning up... 03:09:20 INFO - Return code: 0 03:09:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:09:20 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')]} 03:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:20 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')]} 03:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:20 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 0x10a92a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5fbc7bc10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, '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.uUqLUHpMeO/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.JUv00mt8wb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 03:09:20 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 03:09:20 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 03:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:20 INFO - 'HOME': '/Users/cltbld', 03:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:20 INFO - 'LOGNAME': 'cltbld', 03:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:20 INFO - 'MOZ_NO_REMOTE': '1', 03:09:20 INFO - 'NO_EM_RESTART': '1', 03:09:20 INFO - 'PAGER': '/bin/cat', 03:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:20 INFO - 'PWD': '/builds/slave/test', 03:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:20 INFO - 'SHELL': '/bin/bash', 03:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:20 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:20 INFO - 'USER': 'cltbld', 03:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:20 INFO - 'XPC_FLAGS': '0x0', 03:09:20 INFO - 'XPC_SERVICE_NAME': '0', 03:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:09:21 INFO - Cleaning up... 03:09:21 INFO - Return code: 0 03:09:21 INFO - Running post-action listener: _resource_record_post_action 03:09:21 INFO - Running post-action listener: _start_resource_monitoring 03:09:21 INFO - Starting resource monitoring. 03:09:21 INFO - [mozharness: 2016-10-15 10:09:21.086903Z] Finished create-virtualenv step (success) 03:09:21 INFO - [mozharness: 2016-10-15 10:09:21.087996Z] Running install step. 03:09:21 INFO - Running pre-action listener: _resource_record_pre_action 03:09:21 INFO - Running main action method: install 03:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:09:21 INFO - Reading from file tmpfile_stdout 03:09:21 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:09:21 INFO - Reading from file tmpfile_stdout 03:09:21 INFO - Output received: 03:09:21 INFO - Usage: mozinstall [options] installer 03:09:21 INFO - Options: 03:09:21 INFO - -h, --help show this help message and exit 03:09:21 INFO - -d DEST, --destination=DEST 03:09:21 INFO - Directory to install application into. [default: 03:09:21 INFO - "/builds/slave/test"] 03:09:21 INFO - --app=APP Application being installed. [default: firefox] 03:09:21 INFO - mkdir: /builds/slave/test/build/application 03:09:21 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'] 03:09:21 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 03:09:55 INFO - Reading from file tmpfile_stdout 03:09:55 INFO - Output received: 03:09:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:09:55 INFO - Running post-action listener: _resource_record_post_action 03:09:55 INFO - [mozharness: 2016-10-15 10:09:55.783525Z] Finished install step (success) 03:09:55 INFO - [mozharness: 2016-10-15 10:09:55.783635Z] Running run-tests step. 03:09:55 INFO - Running pre-action listener: _resource_record_pre_action 03:09:55 INFO - Running main action method: run_tests 03:09:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:55 INFO - 2016-10-15 03:09:55.797 screenresolution[1947:21735] starting screenresolution argv=screenresolution get 03:09:55 INFO - 2016-10-15 03:09:55.800 screenresolution[1947:21735] Display 0: 1600x1200x32@60 03:09:55 INFO - 2016-10-15 03:09:55.806 screenresolution[1948:21737] starting screenresolution argv=screenresolution list 03:09:55 INFO - Available Modes on Display 0 03:09:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:56 INFO - Intel Iris: 03:09:56 INFO - Chipset Model: Intel Iris 03:09:56 INFO - Type: GPU 03:09:56 INFO - Bus: Built-In 03:09:56 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:56 INFO - Vendor: Intel (0x8086) 03:09:56 INFO - Device ID: 0x0a2e 03:09:56 INFO - Revision ID: 0x0009 03:09:56 INFO - Displays: 03:09:56 INFO - Display: 03:09:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:56 INFO - Display Serial Number: 1600x1200 60 03:09:56 INFO - Main Display: Yes 03:09:56 INFO - Mirror: Off 03:09:56 INFO - Online: Yes 03:09:56 INFO - Rotation: Supported 03:09:56 INFO - Return code: 0 03:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:56 INFO - Python 2.7.3 03:09:56 INFO - Return code: 0 03:09:56 INFO - grabbing minidump binary from tooltool 03:09:56 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')]} 03:09:56 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 0x10a73ed30>, '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 0x10a564db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a736b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:56 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 03:09:56 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 03:09:56 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 03:09:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:56 INFO - Return code: 0 03:09:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:09:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:09:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:56 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/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 03:09:56 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/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 03:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uUqLUHpMeO/Render', 03:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:09:56 INFO - 'HOME': '/Users/cltbld', 03:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:09:56 INFO - 'LOGNAME': 'cltbld', 03:09:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:56 INFO - 'MOZ_NO_REMOTE': '1', 03:09:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:56 INFO - 'NO_EM_RESTART': '1', 03:09:56 INFO - 'PAGER': '/bin/cat', 03:09:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:56 INFO - 'PWD': '/builds/slave/test', 03:09:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:09:56 INFO - 'SHELL': '/bin/bash', 03:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JUv00mt8wb/Listeners', 03:09:56 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 03:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:09:56 INFO - 'USER': 'cltbld', 03:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:56 INFO - 'XPC_FLAGS': '0x0', 03:09:56 INFO - 'XPC_SERVICE_NAME': '0', 03:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:09:56 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/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 03:09:56 INFO - mozversion application_buildid: 20161015020935 03:09:56 INFO - mozversion application_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 03:09:56 INFO - mozversion application_display_name: Nightly 03:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:56 INFO - mozversion application_name: Firefox 03:09:56 INFO - mozversion application_remotingname: firefox 03:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:09:56 INFO - mozversion application_vendor: Mozilla 03:09:56 INFO - mozversion application_version: 52.0a1 03:09:56 INFO - mozversion platform_buildid: 20161015020935 03:09:56 INFO - mozversion platform_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 03:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:09:56 INFO - mozversion platform_version: 52.0a1 03:09:56 INFO - using testdate: 1476526196 03:09:56 INFO - actual date: 1476526196 03:09:56 INFO - starting webserver on 'localhost:56632' 03:09:56 INFO - SUITE-START | Running 2 tests 03:09:56 INFO - TEST-START | dromaeo_css 03:09:56 INFO - operating with platform_type : mac_ 03:09:56 INFO - Initialising browser for dromaeo_css test... 03:09:56 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp1AmLjP/profile http://localhost:56632/getInfo.html) 03:09:58 INFO - PROCESS | 1958 | 2016-10-15 03:09:58.920 plugin-container[1960:21863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c37, name = 'com.apple.tsm.portname' 03:09:58 INFO - PROCESS | 1958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:09:58 INFO - PROCESS | 1958 | 2016-10-15 03:09:58.923 plugin-container[1960:21863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 03:09:58 INFO - PROCESS | 1958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:09:58 INFO - PROCESS | 1958 | 2016-10-15 03:09:58.923 plugin-container[1960:21863] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:09:58 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 03:09:58 INFO - PROCESS | 1958 | colorDepth:24 03:09:58 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 03:09:58 INFO - PROCESS | 1958 | __metrics 03:09:59 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 03:09:59 INFO - TEST-INFO | 1958: exit 0 03:09:59 INFO - Browser initialized. 03:09:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:09:59 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp1AmLjP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:02 INFO - PROCESS | 1961 | 2016-10-15 03:10:02.400 plugin-container[1962:21978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 03:10:02 INFO - PROCESS | 1961 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:10:02 INFO - PROCESS | 1961 | 2016-10-15 03:10:02.401 plugin-container[1962:21978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 03:10:02 INFO - PROCESS | 1961 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:10:02 INFO - PROCESS | 1961 | 2016-10-15 03:10:02.401 plugin-container[1962:21978] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:10:11 INFO - PROCESS | 1961 | RSS: Main: 237383680 03:10:11 INFO - PROCESS | 1961 | 03:11:01 INFO - PROCESS | 1961 | 1476526261620 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] 03:13:15 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56632/tests/dromaeo/cssquery-ext.html) 03:13:16 INFO - PROCESS | 1961 | RSS: Main: 251449344 03:13:16 INFO - PROCESS | 1961 | 03:16:19 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-ext.html (next: http://localhost:56632/tests/dromaeo/cssquery-jquery.html) 03:16:19 INFO - PROCESS | 1961 | RSS: Main: 264114176 03:16:19 INFO - PROCESS | 1961 | 03:19:21 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56632/tests/dromaeo/cssquery-mootools.html) 03:19:22 INFO - PROCESS | 1961 | RSS: Main: 268709888 03:19:22 INFO - PROCESS | 1961 | 03:22:24 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56632/tests/dromaeo/cssquery-prototype.html) 03:22:24 INFO - PROCESS | 1961 | RSS: Main: 268197888 03:22:24 INFO - PROCESS | 1961 | 03:25:27 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56632/tests/dromaeo/cssquery-yui.html) 03:25:28 INFO - PROCESS | 1961 | RSS: Main: 273960960 03:25:28 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:56632/tests/dromaeo/cssquery-yui.html (next: http://localhost:56632/tests/dromaeo/cssquery-dojo.html) 03:28:31 INFO - PROCESS | 1961 | RSS: Main: 276742144 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | __start_tp_report 03:28:31 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 03:28:31 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 03:28:31 INFO - PROCESS | 1961 | |i|pagename|runs| 03:28:31 INFO - PROCESS | 1961 | |0;dojo.html;3213.421584114861;3228.903132906012;3233.2563510392606;3281.819499927503;3298.818564978926;5358.33020872391;5373.328333958255;5378.408375078743;5428.348598168215;5471.945280547194;5425.7287135643255;5473.2063850741715;5520.613557051008;5538.75075621597;5663.405342439047;4983.451820299764;5048.091343558158;5098.872528186806;5122.206058060988;5125.384953805548;4124.340105583107;5083.110455670261;5151.896962060757;5159.484051594829;5181.663191892534;5124.205748109049;5135.3837539495125;5150.845474635748;5171.50870667286;5230.816921407752;4965.180745177042;4988.102141614508;5022.447530771612;5027.12025395558;5068.18908974566;4986.700797952099;5022.372203474566;5044.545990860804;5050.318207042076;5063.164577844651;4188.7905604719945;5395.649282796645;5535.142052981794;5552.222688823568;5552.3892371839065;5723.914141287884;5887;5967.940320596782;6013.879722405527;6017.217761690996;6097.4036925702085;6109.981658125371;6122.459144589048;6127.31169931711;6138.5416718686565;5592.412796656374;5624.803131890364;5628.915566266509;5634.5210657093785;5651.434856514356;4468.486124095771;4953;5724.912266669319;6187.81436556904;6231.252249729971;4700.177468942989;5301.920471192858;5806.4193580641595;5843;5898.469137777534;5912.733926973297;5990.071538911476;6048.243969503812;6050.54620903434;6068.51451883857;5361.249425080492;5655.321361436571;5917.704114794329;5935.080062590306;5987.790427335022;4943.937053533507;5846.298444186725;5937.940620593825;5985.700714964321;5999.100134979788;4582.564656357641;4789.3294938708605;4808.0624278266105;4809.158397280532;4857.514248575114;3654.853805847736;4000.4799376080923;4183.372494125844;4261.680373971964;4304.913901721948;5524.558035357162;5594.552435805126;5597.63615365;5606.018946684314;5606.159076138611;6090.817275481742;6090.969545152335;6092.116643086816;6108.755649774048;6141.907871381933;5424.457554244623;5493.368262649767;5548.056830338852;5573.693446860461;5679.403662615448;5323.148296272578;5323.627346085815;5332.413434522199;5339.145736682112;5377.27406800077;6195.4424101831055;6200.720967556471;6223.222097237845;6232.844178895382;6241.970074937766;5927.555433342603;6016.849578760566;6051.334353221054;6145.907811382922;6156.045812899008;5559.833205003856;5694.544436445157;6143.815685529441;6156.076588511759;6177.84555386119;5984.431479009487;5999.91000135007;6037.15479832815;6043.516518678407;6058.878822423439;5848.444397782204;5907.438793314628;6102.4812890902995;6111.113888486234;6114.602550834182;5765.682887441231;5766.048601980626;5827.184194212899;5866.442687944638;5929.644221346733;5801.013827649225;5811.389804070512;5820;5836.153757705194;5838.386969368155;4493.236149854598;5571.997040532743;5631.239782629293;5636.577256705681;5689.544836412994;5893.705314734332;5901.616394934315;5922.200502932222;5943.91084133747;5961.046232602763;5694.487496125369;5706.229658996149;5731.226284451545;5753.165790960371;5757.9424205757405 03:28:31 INFO - PROCESS | 1961 | |1;ext.html;501.8193450357872;502.7260143221948;510.9361329833773;512.172840862008;514.6088972380991;30505.847470762645;39282.214355712866;40713.38929916054;40732.18535629286;40783.79608101959;41359;41471.17057658845;42212.78893605528;42275.94310142248;42303.94240143998;9229.723108306745;9520.285978551601;9558.28312876537;9560.569774360136;9568.473733944631;8814.823703525926;9407.38851974623;9464.479453630047;9512.048795120501;9531.571079301413;8130.512169269833;8805.955970220171;9539.666111686092;9540.901001779632;9545.61817527298;9333.85999210009;9465.716028519155;9524.619015239383;9526.428414295164;9550.140487356102;8016.198380161995;9359.48522831244;9374.953125234399;9391.483468409235;9484.810303793955;39850.80447586577;39935;40289.395659065136;40416.79791601023;40601;3437.5874895012757;3608.657177568127;3613.7470377073614;3715.3869611514338;4296.334068219399;27740.722592774015;30931.665939989587;31150.84424577885;31211;31642.683573164202;3093.628764548246;3145.937081258362;3174.761892858022;3248.4640034394533;3249.3014001989686;475849;478354;482495.58752206014;482704;484826;51932.48067519352;51972.740136299835;57458.42541574531;62704;67028.66485667638;67064.99402508966;70497.64751176313;70633.64683176551;71488.28511714921;71674;16472.258748356115;16725.749113763304;16744.330226790793;16769.826112172275;16783.748243776354;12602.432890519949;12745.681357966125;12773;12818.67953301175;12967.740645187043;16097.597560060858;20472.488187795425;20487.38537843867;20501.38495845127;20515.974201289875;7683.731069412544;7973.880391794128;8589.876859107664;8647.351448641377;8712.738617841474;866.900306464752;977.6969139566758;996.6362277768562;998.930074894765;1001.9549120289604;24346.63480047801;26745.86627066891;29025.41949161047;30215;30823.537646935314;998.9750256243652;1034.4569101221919;1064.7125276175389;1088.3198001249218;1121.4616983847798;15577.299021544057;15799.921000395154;15898.841011589737;15987.840121598636;16112.355505779638;593170;626947;634425;635724;635967;58303.70848145817;58884.11673824896;58980.41019589749;59157.112643310385;59247;1346.1922846292146;1381.72365526893;1386.0782579584666;1389.979150312746;1394.8326200855759;29083.12750617485;30076.5488517668;30356;30422.048062697853;30483.390332193674;50923;51049;51250.74374628103;51317;51490.74254628853;553247;558160;558640;559004;559864;42774;42960.71117866469;43289.3506597395;43545.78227108971;43619.78190109029;46730.53269467262;47481.76259118682;47987.76006119947;48594.75702621464;49148.017039659724;38937.6106238934;39453.49017412095;39752.60247397605;40966.59033409747;42062.57937420587;30046.69953300439;37372;39584;40362.39456408215;40547.797261013504;37197.814010929775;37860.62139378681;38452;38664.6133538661;38717.61282387253;33647.15882102967;34641;34943.12642183864;35086.64913350834;35149.47275790916;25229.11698090558;25639.871800640878;25660.101896433534;26300.605490917267;26327.473450531266 03:28:31 INFO - PROCESS | 1961 | |2;jquery.html;273.6183024680569;362.99637003629965;374.501912456433;376.71369758983167;396.2985515637322;18959.33642322519;19412.320568780095;19641.116149773257;19688.704669429953;19939.800601993975;19257.037148142572;19434;19667.606647867033;19711.211551537956;19891.30380436685;4872.342233798445;5519.530839878606;5841.85395365115;5842.47417732404;5864.912026319608;5626;5694.003549378863;5751.281089863767;5760.62555933865;5765.538756899459;5416.702081385522;5649.830505084834;5733.283339582552;5744.913826292609;5776.162456443813;5625.662460252377;5663.745131469093;5671.6597004179885;5676.148577713335;5676.545876329925;4723.220668589679;4888.657793954425;4930.679505832145;4946.084974279734;4949.480304568005;24005.27984160478;24111.397215069588;24133.87933060341;24149.7585024151;24304.270871873694;2383.9284821455385;2403.6034054381007;2581.7805486533666;2595.5198288316533;2834.9291267718268;14310.85689143116;14477.42090316386;14869.330880110421;14949.775753363709;15456.149911754848;1777.8222177782247;1807.0874208524742;1817.009729697318;1828.7988321284647;1861.1810803246663;77889;100253;101588.46028849264;103295.48352258191;104304;8107.716229931924;10010.449425281533;10109.797804043877;10133.240006999504;10408.947955260175;10093.343932644355;10937.671869843918;12742.745145097231;12786.360681965865;12848.743025139445;6628.5691430056895;8066.83866322682;8215.301699355503;8352.665893364197;8362.874556881652;8230.300424463869;8288.544130072783;8342.916570834213;8386.245237928615;8520.105388934073;6071.574989750675;6185.752569897154;6220.284667263322;6260.968695156495;6315.115883776275;1793.5964408008094;1823.5988082621802;1847.353426300784;1852.3146435818833;1860.1071485686675;904.4392476664378;927.9977624165884;929.6746138851483;988.5502096546054;998.2463240253562;16196.838031619769;19547.706784398244;20860.269890553758;21263.468413289484;21295.36113916585;882.2677177942293;908.1644886704248;965.6958058211641;968.3124981263242;1010.3988127064385;10374.377537347784;10461.895381046092;10557.788844223072;11159.553617855196;11254.381009044417;521320;528522;529694.3515282399;536770;544699;96389.51805240929;133676;135656;139810;141454.29272853775;924.306769922558;955.9617615295449;968.3512046928574;993.0913214408735;996.880374355082;14082.22547759842;17718.11409429549;18050.548736281697;18265.178066987282;18686.53283667865;37174.442383363734;50794.74602626963;51224.74387628038;55097;56393.71803140958;54080.72959635334;68399.65800170967;70275;71168.64415677889;71817;7504.174540800398;7511.286427789351;7705.9211710361715;7788.766337009899;8022.638981245741;8702.782430439036;9158.175764181256;12356.25862448256;12399.690007749878;12483.251004939733;10238.795224095327;10484.895151048391;10752.193585480964;10864.945675271572;11003.779924401308;10198.592056317664;10598.31110977784;10661.786764264827;10804.405757683402;10958.890411095786;10265.076143147153;10430.791384172426;10807;11160.386178760245;11245.606403776155;7616.162222155669;7801.4929029612895;7851.60741962911;7905.209479052049;7979.321757650432;9690.127888489787;10728.570857165938;11011.504482298156;11046.944765276123;11171.72070698239 03:28:31 INFO - PROCESS | 1961 | |3;mootools.html;1495.2673190136834;1526.9083854968703;1786.187284785422;1892.7539419875413;1936.7869534351219;7917.960410197941;8162.795930101735;8411.705590304333;9001.414908030973;9018.95490522548;6539;8668.73993780186;8682.739517814476;8775.385722999377;8785;2348.988255058722;2366.0535785685693;2366.9408264793346;2372.098602531036;2378.0606660369144;2344.7069116360453;2349.001674288429;2377.227401094651;2384.654225137354;2391.4021494626345;2346.9061237550477;2359.9882000589973;2368.5973384524586;2372.323887692008;2377.263048454976;2324.0471406723163;2332.078828862598;2335.8364914455997;2344.78896899279;2368.182976872993;2054.5582699719484;2143.767333783081;2321.8490798098237;2326.3835083702834;2341.5785158671433;8840.071792461827;8871.467711937305;8877.467351958903;8907.910920890772;8983.910160898373;5237.973810130925;5246.449122842123;5347.957148356072;5395.865103372408;5440.102383106782;3483.2685136121445;3507.2810073934784;3602.1534939289245;3610.2238018825815;3645.7447978641508;1010.5099026971913;1044.7701505668817;1046.9162467002698;1063.239783554762;1069.7806949575318;11496.827547586709;11534.59628912984;11619.941900290529;11635.941820290844;11644.88355116455;4003.839846406111;4530.935230220895;4736.313234580966;4835.685680430761;4838.879028024327;9796.755081122887;9812.82246130469;9871.703848884401;9883.703488895344;9888.110070093582;5380.112281473591;5398.109311963561;5404.270423492857;5410.48600382963;5412.296401467863;3652.817359132086;4572.154151481986;4694.765261736899;4877.170880950247;4962.851114466572;3913.1391093959282;3950.486436763202;4035.233305671913;4048.3927410888014;4083.612056854594;1121.433675993618;1318.1893135721655;1327.1042046618493;1339.136257114156;1351.7566837969064;799.9241020826978;908.5094049213351;918.5453200665713;929.665320484625;969.9718298603503;5575.581831362664;5847.707614619252;5877.941970445361;5956.195913551615;6067.150598916155;373.25349301397205;451.64094544836934;453.57590652739793;880.1858281089966;978.5498670611456;3778.6221377861993;3906.9609303907164;3932.292187406237;4000.9797501636895;4006.1186538961383;10248.948755256177;10548.736281593021;10554.525046372932;10556.997085276886;10560.788784224425;9939.50302484873;10491.895081049244;10531.52608132636;10553.788924221473;10596.470176491144;7916.366690664733;8121.959390203011;8128.349732021424;8147.226013528705;8183.631736571869;5181;5219.9217011744095;5417.458254174551;5444.455554444524;6259.280182778856;9498.19265362452;9901.55443005052;9953.402795832273;9968.900310997087;9970.900290997288;9178.541072946193;9335.25317974574;9634.614615415305;9984.101430871257;10147.746306342106;7258.3104605062435;7285.744998925013;7289.854202915806;7335.4498412618195;7378.077740282465;7957.920420795718;8009.399295053011;8040.195980402147;8048.356131509348;8052.993375828021;7144.64276786169;7230.783076507713;7253.347198751927;7331.4134869209265;7357.484976051625;7129.287071293037;7146.285371462812;7172.318629730167;7213.242609525924;7266.600336981305;5257.868553286198;5785;6287.842803929939;6878.105846239957;6915.03189553473;4523.932141017953;4718.7168769873915;4849.4908034655855;4930.8767280818265;4983.377077865267;4313.525512193593;4744.288356746516;4853.174960256835;4987.326710893983;5130.897382052263 03:28:31 INFO - PROCESS | 1961 | |4;prototype.html;299.8096208907343;301.9109362737992;308.2924687841403;311.982840943748;313.7192212969392;5009;5245.554127899133;5507.476789704977;5533.91699124513;5548.4451554844545;4702.90594188116;5278.551323137528;5284.603654725892;5348.786048558053;5403.46001389603;3580.319739249547;3871.935217815102;4139.730917490354;4144.48193975753;4158.8960275993195;3082.830444325561;3616;3742.7754334739866;4161.750294982296;4165.791710414483;3524.1189702574356;3966.6033396660246;4066.06480509483;4105.651019663333;4111.923478643281;4094.467719196515;4105.486814148231;4113.4035564843225;4127.688494443121;4134.4831896013;3578.481120237577;3585.103724068983;3593.2094939113354;3599.3521166190076;3614.27714457107;4837;5043.764277751938;5242.453476224523;5289.44460831611;5292.550133238679;4511.639068874482;4722.693024953367;4768.284757286435;4770.76146192689;4776.546228108359;4612.746298953556;5083.805305753145;5626.24314086099;5683.7034519978315;5755.827325180251;3167.635721891989;3567.1795487037866;3625.401808701561;3726.757760745543;3958.7228893977435;5238.030964271622;5507.870886468264;6148.986996371746;6154.384561543855;6178.270084376381;3168.683131686813;3279.8524066417067;3443.8794642187904;3817.9618203818163;3993.84024639017;3154.227214332503;3361.83190840457;3387.932241355159;4004.6395824375945;4054.8378064877666;3536.504889315498;4205.852795152155;4529.728216307032;4709.293605959134;4709.317149013443;4370.2352088384405;4918.401519506175;5391.595630327741;5781.53747700183;5867.301041520863;1279.3475327583;1322.5305016718926;1322.8280323557876;1340.2963444191682;1352.3238380809596;743.1008479739576;757.3297631596078;906.7461110888962;919.1681528216974;920.7191806498948;4329.069250111241;5311.893762124736;5416.377116631559;5493.972530137324;5512.39363669996;5144.408393034774;5266.525372895595;5492.093804522209;5933.520192254906;5954.46409823118;5158.280044975173;5424.915016996538;5441.619086663895;5446.319210098738;5458.590605704588;2521.344450442898;2538.327343254039;2662.3610333519814;2673.4493993483734;2677.7857771378244;4725.432948046257;5171.629518177686;5172.810253641684;5225.634205605571;5244.306345820545;4370.935030421739;4656.301554766812;5029.5221953914315;5793;6077.229374940739;5578.748956296895;6195.504359651217;6243.719032643542;6289.654069026247;6314;4858.489858564941;5757;5947.375525569752;6021.7591296347655;6079.361667024898;4727.9669742011265;5253.737313134252;5351.5718742501285;5671.092625179951;6003.279606447254;5867.471927526543;6242.252169392577;6293.370662933853;6299.236213860127;6316.336784637547;3941.4481972523295;4057.107436363995;4083.244599749056;4111.342185250345;4127.442795222607;5649.22049554389;5905.143754155709;5934.643921364732;5973.223480947449;5982;4363.520012798526;5229.869253268546;5739.8565035874435;5890.381509941566;5895.852603684771;4821.6383771218;5344.652597581145;5635.549156067586;5873.825234952941;5978.701064946648;4589.678722489393;5650.0959846424375;5719.8856022880145;5736.913946290892;5770.769169233352;5824.5340372770925;5831.329397119385;5839.416058394127;5893.528517718658;5906.586538942404;4850.53919877611;5575.581831362745;5699.808107459836;5761.48146666802;5767.423257674199 03:28:31 INFO - PROCESS | 1961 | |5;yui.html;632.8607706304614;720.9423246140308;724.8803947348688;747.1482509938671;781.9100803407609;15178.31697573609;15659.295331710073;16135.43525976591;16136.999999999985;16183;14521.49174778883;14688.118712877234;14701.852981470181;14703.852961470382;14711;701.1901254051579;720.7225218290944;874.7419511244167;877.8376000439907;899.0245583541865;899.6761165980274;905.2260317428603;905.710172744722;910.0399078971682;912.803747194353;947.6493697331997;967.4920666649995;969.7624082099895;970.4419958523841;973.2068364283086;959.2230293462283;962.4417837654144;962.7256231973854;964.1900803325206;964.5948701545368;702.4906942466722;713.6467448612918;715.2239819795528;716.4340171264695;719.2088702427341;14463.20452375119;14627.63430914225;14797.778033329509;14837.629059273497;14847.777283340758;14374.425022999067;14444.422223111063;14511.564653060424;14617.853821461755;14828.481003164838;11890.464929078125;11911.821322680167;11929.28424294545;12009.879901200964;12192.451339689735;3741.2143449875557;3885.106425522146;3888.9611103889165;3919.98040009801;3922.5685174630767;112873;115947.42026289814;116055.83944160535;116116.99999999916;116683;11130.49912753928;11136.38749868765;11136.944315278372;11173.72065698364;11620.244684095507;18470.445886623424;19059.714104288447;22897.08411663515;23064.4233894154;23096.538069238522;6790.354916282945;7963.442559020813;8031.518108913484;8187.345012399113;8303.211194936472;4454.532274111171;4467.798949047301;4516.570925762047;4519.683622146418;4590.472095709036;3599.2261663741897;3669.486271921933;3721.7953012584026;3723.1436769542615;3724.845297957642;592.691800263869;657.9868402631921;659.9571027883172;671.660811290305;673.9865202695919;524.7586110389263;560.436761055137;569.6809786519563;653.4543656047254;700.6601798128006;9100.772480688036;9252.420749423087;9434.811303774024;9437.197838183694;9442.38624489406;582.0570675505708;594.9345571987078;642.4667525953447;660.7918505670698;667.7896462614261;3893.805309734502;4434.467863856358;4499.257622492252;4534.79593418297;4556.430446194226;83305.58347208225;84174;105403.41894871583;153111.2344438293;157241;140697;142557.28721356328;143589.28205358906;143682;143812.28093859673;70918.64540677263;71106.64446677837;74161.6291918537;118191.81808181808;125166.12250816062;8699.81690372714;8830.514321712368;8876.778080548038;8900.554972251492;8930.464172149692;49634.75182624064;64725;65122.34877651163;65682.01476977945;66896;96489;99619;101302;102753;104683.4765826166;11818.881811182122;11970.76058478843;12005.699857503632;12492.375991121096;12576.371181441074;10684.252102353072;10745.785084298426;12727.918126959312;12894.48422063107;13108;9652.324337296322;11729.47217375203;11845;11997.76004479888;12410.379481025731;12037.03703703684;12153.81769273444;12212.389380531116;12330.81503777462;12649.93675031619;11772.411379430823;11782.116341274268;11908.464119114833;12361.752764944831;12370.13409061393;9332.30007749408;9559.996200398858;10325.63860264887;10340;10507.89492105069;9607.855882161633;10074.899251007397;10216.284860059724;10267.973202679672;10391.428471434143 03:28:31 INFO - PROCESS | 1961 | __end_tp_report 03:28:31 INFO - PROCESS | 1961 | __start_cc_report 03:28:31 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,361 03:28:31 INFO - PROCESS | 1961 | __end_cc_report 03:28:31 INFO - PROCESS | 1961 | __startTimestamp1476527311616__endTimestamp 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | ------- Summary: start ------- 03:28:31 INFO - PROCESS | 1961 | Number of tests: 6 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#0] dojo.html Cycles:165 Average:5492.95 Median:5636.58 stddev:651.30 (11.6%) stddev-sans-first:628.27 03:28:31 INFO - PROCESS | 1961 | Values: 3213.4 3228.9 3233.3 3281.8 3298.8 5358.3 5373.3 5378.4 5428.3 5471.9 5425.7 5473.2 5520.6 5538.8 5663.4 4983.5 5048.1 5098.9 5122.2 5125.4 4124.3 5083.1 5151.9 5159.5 5181.7 5124.2 5135.4 5150.8 5171.5 5230.8 4965.2 4988.1 5022.4 5027.1 5068.2 4986.7 5022.4 5044.5 5050.3 5063.2 4188.8 5395.6 5535.1 5552.2 5552.4 5723.9 5887.0 5967.9 6013.9 6017.2 6097.4 6110.0 6122.5 6127.3 6138.5 5592.4 5624.8 5628.9 5634.5 5651.4 4468.5 4953.0 5724.9 6187.8 6231.3 4700.2 5301.9 5806.4 5843.0 5898.5 5912.7 5990.1 6048.2 6050.5 6068.5 5361.2 5655.3 5917.7 5935.1 5987.8 4943.9 5846.3 5937.9 5985.7 5999.1 4582.6 4789.3 4808.1 4809.2 4857.5 3654.9 4000.5 4183.4 4261.7 4304.9 5524.6 5594.6 5597.6 5606.0 5606.2 6090.8 6091.0 6092.1 6108.8 6141.9 5424.5 5493.4 5548.1 5573.7 5679.4 5323.1 5323.6 5332.4 5339.1 5377.3 6195.4 6200.7 6223.2 6232.8 6242.0 5927.6 6016.8 6051.3 6145.9 6156.0 5559.8 5694.5 6143.8 6156.1 6177.8 5984.4 5999.9 6037.2 6043.5 6058.9 5848.4 5907.4 6102.5 6111.1 6114.6 5765.7 5766.0 5827.2 5866.4 5929.6 5801.0 5811.4 5820.0 5836.2 5838.4 4493.2 5572.0 5631.2 5636.6 5689.5 5893.7 5901.6 5922.2 5943.9 5961.0 5694.5 5706.2 5731.2 5753.2 5757.9 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#1] ext.html Cycles:180 Average:69730.85 Median:42137.68 stddev:148797.63 (353.1%) stddev-sans-first:149124.26 03:28:31 INFO - PROCESS | 1961 | Values: 501.8 502.7 510.9 512.2 514.6 30505.8 39282.2 40713.4 40732.2 40783.8 41359.0 41471.2 42212.8 42275.9 42303.9 9229.7 9520.3 9558.3 9560.6 9568.5 8814.8 9407.4 9464.5 9512.0 9531.6 8130.5 8806.0 9539.7 9540.9 9545.6 9333.9 9465.7 9524.6 9526.4 9550.1 8016.2 9359.5 9375.0 9391.5 9484.8 39850.8 39935.0 40289.4 40416.8 40601.0 3437.6 3608.7 3613.7 3715.4 4296.3 27740.7 30931.7 31150.8 31211.0 31642.7 3093.6 3145.9 3174.8 3248.5 3249.3 475849.0 478354.0 482495.6 482704.0 484826.0 51932.5 51972.7 57458.4 62704.0 67028.7 67065.0 70497.6 70633.6 71488.3 71674.0 16472.3 16725.7 16744.3 16769.8 16783.7 12602.4 12745.7 12773.0 12818.7 12967.7 16097.6 20472.5 20487.4 20501.4 20516.0 7683.7 7973.9 8589.9 8647.4 8712.7 866.9 977.7 996.6 998.9 1002.0 24346.6 26745.9 29025.4 30215.0 30823.5 999.0 1034.5 1064.7 1088.3 1121.5 15577.3 15799.9 15898.8 15987.8 16112.4 593170.0 626947.0 634425.0 635724.0 635967.0 58303.7 58884.1 58980.4 59157.1 59247.0 1346.2 1381.7 1386.1 1390.0 1394.8 29083.1 30076.5 30356.0 30422.0 30483.4 50923.0 51049.0 51250.7 51317.0 51490.7 553247.0 558160.0 558640.0 559004.0 559864.0 42774.0 42960.7 43289.4 43545.8 43619.8 46730.5 47481.8 47987.8 48594.8 49148.0 38937.6 39453.5 39752.6 40966.6 42062.6 30046.7 37372.0 39584.0 40362.4 40547.8 37197.8 37860.6 38452.0 38664.6 38717.6 33647.2 34641.0 34943.1 35086.6 35149.5 25229.1 25639.9 25660.1 26300.6 26327.5 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#2] jquery.html Cycles:180 Average:32023.42 Median:1598.96 stddev:89033.42 (5568.2%) stddev-sans-first:89251.27 03:28:31 INFO - PROCESS | 1961 | Values: 273.6 363.0 374.5 376.7 396.3 18959.3 19412.3 19641.1 19688.7 19939.8 19257.0 19434.0 19667.6 19711.2 19891.3 4872.3 5519.5 5841.9 5842.5 5864.9 5626.0 5694.0 5751.3 5760.6 5765.5 5416.7 5649.8 5733.3 5744.9 5776.2 5625.7 5663.7 5671.7 5676.1 5676.5 4723.2 4888.7 4930.7 4946.1 4949.5 24005.3 24111.4 24133.9 24149.8 24304.3 2383.9 2403.6 2581.8 2595.5 2834.9 14310.9 14477.4 14869.3 14949.8 15456.1 1777.8 1807.1 1817.0 1828.8 1861.2 77889.0 100253.0 101588.5 103295.5 104304.0 8107.7 10010.4 10109.8 10133.2 10408.9 10093.3 10937.7 12742.7 12786.4 12848.7 6628.6 8066.8 8215.3 8352.7 8362.9 8230.3 8288.5 8342.9 8386.2 8520.1 6071.6 6185.8 6220.3 6261.0 6315.1 1793.6 1823.6 1847.4 1852.3 1860.1 904.4 928.0 929.7 988.6 998.2 16196.8 19547.7 20860.3 21263.5 21295.4 882.3 908.2 965.7 968.3 1010.4 10374.4 10461.9 10557.8 11159.6 11254.4 521320.0 528522.0 529694.4 536770.0 544699.0 96389.5 133676.0 135656.0 139810.0 141454.3 924.3 956.0 968.4 993.1 996.9 14082.2 17718.1 18050.5 18265.2 18686.5 37174.4 50794.7 51224.7 55097.0 56393.7 54080.7 68399.7 70275.0 71168.6 71817.0 7504.2 7511.3 7705.9 7788.8 8022.6 8702.8 9158.2 12356.3 12399.7 12483.3 10238.8 10484.9 10752.2 10864.9 11003.8 10198.6 10598.3 10661.8 10804.4 10958.9 10265.1 10430.8 10807.0 11160.4 11245.6 7616.2 7801.5 7851.6 7905.2 7979.3 9690.1 10728.6 11011.5 11046.9 11171.7 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#3] mootools.html Cycles:180 Average:5591.48 Median:4985.35 stddev:3138.82 (63.0%) stddev-sans-first:3132.53 03:28:31 INFO - PROCESS | 1961 | Values: 1495.3 1526.9 1786.2 1892.8 1936.8 7918.0 8162.8 8411.7 9001.4 9019.0 6539.0 8668.7 8682.7 8775.4 8785.0 2349.0 2366.1 2366.9 2372.1 2378.1 2344.7 2349.0 2377.2 2384.7 2391.4 2346.9 2360.0 2368.6 2372.3 2377.3 2324.0 2332.1 2335.8 2344.8 2368.2 2054.6 2143.8 2321.8 2326.4 2341.6 8840.1 8871.5 8877.5 8907.9 8983.9 5238.0 5246.4 5348.0 5395.9 5440.1 3483.3 3507.3 3602.2 3610.2 3645.7 1010.5 1044.8 1046.9 1063.2 1069.8 11496.8 11534.6 11619.9 11635.9 11644.9 4003.8 4530.9 4736.3 4835.7 4838.9 9796.8 9812.8 9871.7 9883.7 9888.1 5380.1 5398.1 5404.3 5410.5 5412.3 3652.8 4572.2 4694.8 4877.2 4962.9 3913.1 3950.5 4035.2 4048.4 4083.6 1121.4 1318.2 1327.1 1339.1 1351.8 799.9 908.5 918.5 929.7 970.0 5575.6 5847.7 5877.9 5956.2 6067.2 373.3 451.6 453.6 880.2 978.5 3778.6 3907.0 3932.3 4001.0 4006.1 10248.9 10548.7 10554.5 10557.0 10560.8 9939.5 10491.9 10531.5 10553.8 10596.5 7916.4 8122.0 8128.3 8147.2 8183.6 5181.0 5219.9 5417.5 5444.5 6259.3 9498.2 9901.6 9953.4 9968.9 9970.9 9178.5 9335.3 9634.6 9984.1 10147.7 7258.3 7285.7 7289.9 7335.4 7378.1 7957.9 8009.4 8040.2 8048.4 8053.0 7144.6 7230.8 7253.3 7331.4 7357.5 7129.3 7146.3 7172.3 7213.2 7266.6 5257.9 5785.0 6287.8 6878.1 6915.0 4523.9 4718.7 4849.5 4930.9 4983.4 4313.5 4744.3 4853.2 4987.3 5130.9 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#4] prototype.html Cycles:180 Average:4560.10 Median:5164.95 stddev:1463.60 (28.3%) stddev-sans-first:1432.35 03:28:31 INFO - PROCESS | 1961 | Values: 299.8 301.9 308.3 312.0 313.7 5009.0 5245.6 5507.5 5533.9 5548.4 4702.9 5278.6 5284.6 5348.8 5403.5 3580.3 3871.9 4139.7 4144.5 4158.9 3082.8 3616.0 3742.8 4161.8 4165.8 3524.1 3966.6 4066.1 4105.7 4111.9 4094.5 4105.5 4113.4 4127.7 4134.5 3578.5 3585.1 3593.2 3599.4 3614.3 4837.0 5043.8 5242.5 5289.4 5292.6 4511.6 4722.7 4768.3 4770.8 4776.5 4612.7 5083.8 5626.2 5683.7 5755.8 3167.6 3567.2 3625.4 3726.8 3958.7 5238.0 5507.9 6149.0 6154.4 6178.3 3168.7 3279.9 3443.9 3818.0 3993.8 3154.2 3361.8 3387.9 4004.6 4054.8 3536.5 4205.9 4529.7 4709.3 4709.3 4370.2 4918.4 5391.6 5781.5 5867.3 1279.3 1322.5 1322.8 1340.3 1352.3 743.1 757.3 906.7 919.2 920.7 4329.1 5311.9 5416.4 5494.0 5512.4 5144.4 5266.5 5492.1 5933.5 5954.5 5158.3 5424.9 5441.6 5446.3 5458.6 2521.3 2538.3 2662.4 2673.4 2677.8 4725.4 5171.6 5172.8 5225.6 5244.3 4370.9 4656.3 5029.5 5793.0 6077.2 5578.7 6195.5 6243.7 6289.7 6314.0 4858.5 5757.0 5947.4 6021.8 6079.4 4728.0 5253.7 5351.6 5671.1 6003.3 5867.5 6242.3 6293.4 6299.2 6316.3 3941.4 4057.1 4083.2 4111.3 4127.4 5649.2 5905.1 5934.6 5973.2 5982.0 4363.5 5229.9 5739.9 5890.4 5895.9 4821.6 5344.7 5635.5 5873.8 5978.7 4589.7 5650.1 5719.9 5736.9 5770.8 5824.5 5831.3 5839.4 5893.5 5906.6 4850.5 5575.6 5699.8 5761.5 5767.4 03:28:31 INFO - PROCESS | 1961 | 03:28:31 INFO - PROCESS | 1961 | [#5] yui.html Cycles:180 Average:24008.53 Median:3887.03 stddev:38732.68 (996.5%) stddev-sans-first:38801.57 03:28:31 INFO - PROCESS | 1961 | Values: 632.9 720.9 724.9 747.1 781.9 15178.3 15659.3 16135.4 16137.0 16183.0 14521.5 14688.1 14701.9 14703.9 14711.0 701.2 720.7 874.7 877.8 899.0 899.7 905.2 905.7 910.0 912.8 947.6 967.5 969.8 970.4 973.2 959.2 962.4 962.7 964.2 964.6 702.5 713.6 715.2 716.4 719.2 14463.2 14627.6 14797.8 14837.6 14847.8 14374.4 14444.4 14511.6 14617.9 14828.5 11890.5 11911.8 11929.3 12009.9 12192.5 3741.2 3885.1 3889.0 3920.0 3922.6 112873.0 115947.4 116055.8 116117.0 116683.0 11130.5 11136.4 11136.9 11173.7 11620.2 18470.4 19059.7 22897.1 23064.4 23096.5 6790.4 7963.4 8031.5 8187.3 8303.2 4454.5 4467.8 4516.6 4519.7 4590.5 3599.2 3669.5 3721.8 3723.1 3724.8 592.7 658.0 660.0 671.7 674.0 524.8 560.4 569.7 653.5 700.7 9100.8 9252.4 9434.8 9437.2 9442.4 582.1 594.9 642.5 660.8 667.8 3893.8 4434.5 4499.3 4534.8 4556.4 83305.6 84174.0 105403.4 153111.2 157241.0 140697.0 142557.3 143589.3 143682.0 143812.3 70918.6 71106.6 74161.6 118191.8 125166.1 8699.8 8830.5 8876.8 8900.6 8930.5 49634.8 64725.0 65122.3 65682.0 66896.0 96489.0 99619.0 101302.0 102753.0 104683.5 11818.9 11970.8 12005.7 12492.4 12576.4 10684.3 10745.8 12727.9 12894.5 13108.0 9652.3 11729.5 11845.0 11997.8 12410.4 12037.0 12153.8 12212.4 12330.8 12649.9 11772.4 11782.1 11908.5 12361.8 12370.1 9332.3 9560.0 10325.6 10340.0 10507.9 9607.9 10074.9 10216.3 10268.0 10391.4 03:28:31 INFO - PROCESS | 1961 | -------- Summary: end -------- 03:28:31 INFO - PROCESS | 1961 | 03:28:32 INFO - TEST-INFO | 1961: exit 0 03:28:32 INFO - TEST-OK | dromaeo_css | took 1115865ms 03:28:32 INFO - TEST-START | kraken 03:28:32 INFO - operating with platform_type : mac_ 03:28:32 INFO - Initialising browser for kraken test... 03:28:32 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp7Az2GJ/profile http://localhost:56632/getInfo.html) 03:28:35 INFO - PROCESS | 1967 | 2016-10-15 03:28:35.066 plugin-container[1968:23874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:28:35 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:28:35 INFO - PROCESS | 1967 | 2016-10-15 03:28:35.069 plugin-container[1968:23874] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 03:28:35 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:28:35 INFO - PROCESS | 1967 | 2016-10-15 03:28:35.069 plugin-container[1968:23874] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:28:35 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 03:28:35 INFO - PROCESS | 1967 | colorDepth:24 03:28:35 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 03:28:35 INFO - PROCESS | 1967 | __metrics 03:28:35 ERROR - PROCESS | 1967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 03:28:35 INFO - TEST-INFO | 1967: exit 0 03:28:35 INFO - Browser initialized. 03:28:35 INFO - Running cycle 1/1 for kraken test... 03:28:36 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp7Az2GJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:38 INFO - PROCESS | 1969 | 2016-10-15 03:28:38.578 plugin-container[1970:23983] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 03:28:38 INFO - PROCESS | 1969 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:28:38 INFO - PROCESS | 1969 | 2016-10-15 03:28:38.579 plugin-container[1970:23983] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 03:28:38 INFO - PROCESS | 1969 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:28:38 INFO - PROCESS | 1969 | 2016-10-15 03:28:38.579 plugin-container[1970:23983] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:28:48 INFO - PROCESS | 1969 | RSS: Main: 237355008 03:28:48 INFO - PROCESS | 1969 | 03:28:51 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56632/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:52 INFO - PROCESS | 1969 | RSS: Main: 249499648 03:28:52 INFO - PROCESS | 1969 | 03:28:54 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56632/tests/kraken/driver.html?testName=audio-dft) 03:28:55 INFO - PROCESS | 1969 | RSS: Main: 258207744 03:28:55 INFO - PROCESS | 1969 | 03:28:58 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56632/tests/kraken/driver.html?testName=audio-fft) 03:28:59 INFO - PROCESS | 1969 | RSS: Main: 260407296 03:28:59 INFO - PROCESS | 1969 | 03:29:01 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56632/tests/kraken/driver.html?testName=audio-oscillator) 03:29:02 INFO - PROCESS | 1969 | RSS: Main: 261283840 03:29:02 INFO - PROCESS | 1969 | 03:29:03 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:04 INFO - PROCESS | 1969 | RSS: Main: 261566464 03:29:04 INFO - PROCESS | 1969 | 03:29:07 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56632/tests/kraken/driver.html?testName=imaging-darkroom) 03:29:07 INFO - PROCESS | 1969 | RSS: Main: 263520256 03:29:07 INFO - PROCESS | 1969 | 03:29:10 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56632/tests/kraken/driver.html?testName=imaging-desaturate) 03:29:11 INFO - PROCESS | 1969 | RSS: Main: 263421952 03:29:11 INFO - PROCESS | 1969 | 03:29:14 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56632/tests/kraken/driver.html?testName=json-parse-financial) 03:29:15 INFO - PROCESS | 1969 | RSS: Main: 264044544 03:29:15 INFO - PROCESS | 1969 | 03:29:16 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:29:17 INFO - PROCESS | 1969 | RSS: Main: 263057408 03:29:17 INFO - PROCESS | 1969 | 03:29:19 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:29:20 INFO - PROCESS | 1969 | RSS: Main: 263188480 03:29:20 INFO - PROCESS | 1969 | 03:29:22 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:29:23 INFO - PROCESS | 1969 | RSS: Main: 263233536 03:29:23 INFO - PROCESS | 1969 | 03:29:26 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:29:26 INFO - PROCESS | 1969 | RSS: Main: 263557120 03:29:26 INFO - PROCESS | 1969 | 03:29:29 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:29:30 INFO - PROCESS | 1969 | RSS: Main: 263614464 03:29:30 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:56632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56632/tests/kraken/driver.html?testName=ai-astar) 03:29:32 INFO - PROCESS | 1969 | RSS: Main: 264876032 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | __start_tp_report 03:29:32 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 03:29:32 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 03:29:32 INFO - PROCESS | 1969 | |i|pagename|runs| 03:29:32 INFO - PROCESS | 1969 | |0;ai-astar;113;118;124;100;175;170;173;118;122;177 03:29:32 INFO - PROCESS | 1969 | |1;audio-beat-detection;152;114;114;168;151;148;136;118;144;117 03:29:32 INFO - PROCESS | 1969 | |2;audio-dft;204;212;245;272;198;198;199;198;194;196 03:29:32 INFO - PROCESS | 1969 | |3;audio-fft;82;60;61;89;59;69;59;59;81;60 03:29:32 INFO - PROCESS | 1969 | |4;audio-oscillator;78;70;87;74;69;71;89;70;68;83 03:29:32 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;91;87;89;87;91;86;90;88;89;105 03:29:32 INFO - PROCESS | 1969 | |6;imaging-darkroom;98;95;98;154;118;95;95;94;98;106 03:29:32 INFO - PROCESS | 1969 | |7;imaging-desaturate;96;89;104;124;127;90;116;146;78;134 03:29:32 INFO - PROCESS | 1969 | |8;json-parse-financial;56;56;57;57;56;58;59;60;58;56 03:29:32 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;69;76;78;75;108;71;78;104;106;109 03:29:32 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;92;91;97;87;78;102;113;88;89;91 03:29:32 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;168;170;159;135;153;149;149;147;207;160 03:29:32 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;174;179;173;176;178;176;177;178;173;186 03:29:32 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;68;69;69;69;73;71;84;81;71;71 03:29:32 INFO - PROCESS | 1969 | __end_tp_report 03:29:32 INFO - PROCESS | 1969 | __start_cc_report 03:29:32 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,934 03:29:32 INFO - PROCESS | 1969 | __end_cc_report 03:29:32 INFO - PROCESS | 1969 | __startTimestamp1476527372428__endTimestamp 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | ------- Summary: start ------- 03:29:32 INFO - PROCESS | 1969 | Number of tests: 14 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:139.00 Median:147.00 stddev:30.64 (20.8%) stddev-sans-first:31.02 03:29:32 INFO - PROCESS | 1969 | Values: 113.0 118.0 124.0 100.0 175.0 170.0 173.0 118.0 122.0 177.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:146.00 stddev:19.34 (13.2%) stddev-sans-first:19.65 03:29:32 INFO - PROCESS | 1969 | Values: 152.0 114.0 114.0 168.0 151.0 148.0 136.0 118.0 144.0 117.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:211.60 Median:201.50 stddev:26.01 (12.9%) stddev-sans-first:27.44 03:29:32 INFO - PROCESS | 1969 | Values: 204.0 212.0 245.0 272.0 198.0 198.0 199.0 198.0 194.0 196.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:67.90 Median:65.00 stddev:11.68 (18.0%) stddev-sans-first:11.21 03:29:32 INFO - PROCESS | 1969 | Values: 82.0 60.0 61.0 89.0 59.0 69.0 59.0 59.0 81.0 60.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.00 stddev:7.87 (10.4%) stddev-sans-first:8.31 03:29:32 INFO - PROCESS | 1969 | Values: 78.0 70.0 87.0 74.0 69.0 71.0 89.0 70.0 68.0 83.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:89.00 stddev:5.44 (6.1%) stddev-sans-first:5.76 03:29:32 INFO - PROCESS | 1969 | Values: 91.0 87.0 89.0 87.0 91.0 86.0 90.0 88.0 89.0 105.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:95.00 stddev:18.68 (19.7%) stddev-sans-first:19.63 03:29:32 INFO - PROCESS | 1969 | Values: 98.0 95.0 98.0 154.0 118.0 95.0 95.0 94.0 98.0 106.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:110.40 Median:112.00 stddev:22.33 (19.9%) stddev-sans-first:23.07 03:29:32 INFO - PROCESS | 1969 | Values: 96.0 89.0 104.0 124.0 127.0 90.0 116.0 146.0 78.0 134.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:1.42 (2.5%) stddev-sans-first:1.42 03:29:32 INFO - PROCESS | 1969 | Values: 56.0 56.0 57.0 57.0 56.0 58.0 59.0 60.0 58.0 56.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:87.40 Median:73.00 stddev:16.93 (23.2%) stddev-sans-first:16.60 03:29:32 INFO - PROCESS | 1969 | Values: 69.0 76.0 78.0 75.0 108.0 71.0 78.0 104.0 106.0 109.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:90.00 stddev:9.47 (10.5%) stddev-sans-first:10.04 03:29:32 INFO - PROCESS | 1969 | Values: 92.0 91.0 97.0 87.0 78.0 102.0 113.0 88.0 89.0 91.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:159.50 stddev:19.60 (12.3%) stddev-sans-first:20.56 03:29:32 INFO - PROCESS | 1969 | Values: 168.0 170.0 159.0 135.0 153.0 149.0 149.0 147.0 207.0 160.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.50 stddev:3.80 (2.1%) stddev-sans-first:3.87 03:29:32 INFO - PROCESS | 1969 | Values: 174.0 179.0 173.0 176.0 178.0 176.0 177.0 178.0 173.0 186.0 03:29:32 INFO - PROCESS | 1969 | 03:29:32 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:71.00 stddev:5.46 (7.7%) stddev-sans-first:5.53 03:29:32 INFO - PROCESS | 1969 | Values: 68.0 69.0 69.0 69.0 73.0 71.0 84.0 81.0 71.0 71.0 03:29:32 INFO - PROCESS | 1969 | -------- Summary: end -------- 03:29:32 INFO - PROCESS | 1969 | 03:29:33 INFO - TEST-INFO | 1969: exit 0 03:29:33 INFO - TEST-OK | kraken | took 61195ms 03:29:33 INFO - SUITE-END | took 1177s 03:29:33 INFO - Completed test suite (00:19:37) 03:29:33 INFO - javascript benchmark 03:29:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.640159450931, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.421584114861, 3228.903132906012, 3233.2563510392606, 3281.819499927503, 3298.818564978926, 5358.33020872391, 5373.328333958255, 5378.408375078743, 5428.348598168215, 5471.945280547194, 5425.7287135643255, 5473.2063850741715, 5520.613557051008, 5538.75075621597, 5663.405342439047, 4983.451820299764, 5048.091343558158, 5098.872528186806, 5122.206058060988, 5125.384953805548, 4124.340105583107, 5083.110455670261, 5151.896962060757, 5159.484051594829, 5181.663191892534, 5124.205748109049, 5135.3837539495125, 5150.845474635748, 5171.50870667286, 5230.816921407752, 4965.180745177042, 4988.102141614508, 5022.447530771612, 5027.12025395558, 5068.18908974566, 4986.700797952099, 5022.372203474566, 5044.545990860804, 5050.318207042076, 5063.164577844651, 4188.7905604719945, 5395.649282796645, 5535.142052981794, 5552.222688823568, 5552.3892371839065, 5723.914141287884, 5887.0, 5967.940320596782, 6013.879722405527, 6017.217761690996, 6097.4036925702085, 6109.981658125371, 6122.459144589048, 6127.31169931711, 6138.5416718686565, 5592.412796656374, 5624.803131890364, 5628.915566266509, 5634.5210657093785, 5651.434856514356, 4468.486124095771, 4953.0, 5724.912266669319, 6187.81436556904, 6231.252249729971, 4700.177468942989, 5301.920471192858, 5806.4193580641595, 5843.0, 5898.469137777534, 5912.733926973297, 5990.071538911476, 6048.243969503812, 6050.54620903434, 6068.51451883857, 5361.249425080492, 5655.321361436571, 5917.704114794329, 5935.080062590306, 5987.790427335022, 4943.937053533507, 5846.298444186725, 5937.940620593825, 5985.700714964321, 5999.100134979788, 4582.564656357641, 4789.3294938708605, 4808.0624278266105, 4809.158397280532, 4857.514248575114, 3654.853805847736, 4000.4799376080923, 4183.372494125844, 4261.680373971964, 4304.913901721948, 5524.558035357162, 5594.552435805126, 5597.63615365, 5606.018946684314, 5606.159076138611, 6090.817275481742, 6090.969545152335, 6092.116643086816, 6108.755649774048, 6141.907871381933, 5424.457554244623, 5493.368262649767, 5548.056830338852, 5573.693446860461, 5679.403662615448, 5323.148296272578, 5323.627346085815, 5332.413434522199, 5339.145736682112, 5377.27406800077, 6195.4424101831055, 6200.720967556471, 6223.222097237845, 6232.844178895382, 6241.970074937766, 5927.555433342603, 6016.849578760566, 6051.334353221054, 6145.907811382922, 6156.045812899008, 5559.833205003856, 5694.544436445157, 6143.815685529441, 6156.076588511759, 6177.84555386119, 5984.431479009487, 5999.91000135007, 6037.15479832815, 6043.516518678407, 6058.878822423439, 5848.444397782204, 5907.438793314628, 6102.4812890902995, 6111.113888486234, 6114.602550834182, 5765.682887441231, 5766.048601980626, 5827.184194212899, 5866.442687944638, 5929.644221346733, 5801.013827649225, 5811.389804070512, 5820.0, 5836.153757705194, 5838.386969368155, 4493.236149854598, 5571.997040532743, 5631.239782629293, 5636.577256705681, 5689.544836412994, 5893.705314734332, 5901.616394934315, 5922.200502932222, 5943.91084133747, 5961.046232602763, 5694.487496125369, 5706.229658996149, 5731.226284451545, 5753.165790960371, 5757.9424205757405], "value": 5453.202290690207, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.8193450357872, 502.7260143221948, 510.9361329833773, 512.172840862008, 514.6088972380991, 30505.847470762645, 39282.214355712866, 40713.38929916054, 40732.18535629286, 40783.79608101959, 41359.0, 41471.17057658845, 42212.78893605528, 42275.94310142248, 42303.94240143998, 9229.723108306745, 9520.285978551601, 9558.28312876537, 9560.569774360136, 9568.473733944631, 8814.823703525926, 9407.38851974623, 9464.479453630047, 9512.048795120501, 9531.571079301413, 8130.512169269833, 8805.955970220171, 9539.666111686092, 9540.901001779632, 9545.61817527298, 9333.85999210009, 9465.716028519155, 9524.619015239383, 9526.428414295164, 9550.140487356102, 8016.198380161995, 9359.48522831244, 9374.953125234399, 9391.483468409235, 9484.810303793955, 39850.80447586577, 39935.0, 40289.395659065136, 40416.79791601023, 40601.0, 3437.5874895012757, 3608.657177568127, 3613.7470377073614, 3715.3869611514338, 4296.334068219399, 27740.722592774015, 30931.665939989587, 31150.84424577885, 31211.0, 31642.683573164202, 3093.628764548246, 3145.937081258362, 3174.761892858022, 3248.4640034394533, 3249.3014001989686, 475849.0, 478354.0, 482495.58752206014, 482704.0, 484826.0, 51932.48067519352, 51972.740136299835, 57458.42541574531, 62704.0, 67028.66485667638, 67064.99402508966, 70497.64751176313, 70633.64683176551, 71488.28511714921, 71674.0, 16472.258748356115, 16725.749113763304, 16744.330226790793, 16769.826112172275, 16783.748243776354, 12602.432890519949, 12745.681357966125, 12773.0, 12818.67953301175, 12967.740645187043, 16097.597560060858, 20472.488187795425, 20487.38537843867, 20501.38495845127, 20515.974201289875, 7683.731069412544, 7973.880391794128, 8589.876859107664, 8647.351448641377, 8712.738617841474, 866.900306464752, 977.6969139566758, 996.6362277768562, 998.930074894765, 1001.9549120289604, 24346.63480047801, 26745.86627066891, 29025.41949161047, 30215.0, 30823.537646935314, 998.9750256243652, 1034.4569101221919, 1064.7125276175389, 1088.3198001249218, 1121.4616983847798, 15577.299021544057, 15799.921000395154, 15898.841011589737, 15987.840121598636, 16112.355505779638, 593170.0, 626947.0, 634425.0, 635724.0, 635967.0, 58303.70848145817, 58884.11673824896, 58980.41019589749, 59157.112643310385, 59247.0, 1346.1922846292146, 1381.72365526893, 1386.0782579584666, 1389.979150312746, 1394.8326200855759, 29083.12750617485, 30076.5488517668, 30356.0, 30422.048062697853, 30483.390332193674, 50923.0, 51049.0, 51250.74374628103, 51317.0, 51490.74254628853, 553247.0, 558160.0, 558640.0, 559004.0, 559864.0, 42774.0, 42960.71117866469, 43289.3506597395, 43545.78227108971, 43619.78190109029, 46730.53269467262, 47481.76259118682, 47987.76006119947, 48594.75702621464, 49148.017039659724, 38937.6106238934, 39453.49017412095, 39752.60247397605, 40966.59033409747, 42062.57937420587, 30046.69953300439, 37372.0, 39584.0, 40362.39456408215, 40547.797261013504, 37197.814010929775, 37860.62139378681, 38452.0, 38664.6133538661, 38717.61282387253, 33647.15882102967, 34641.0, 34943.12642183864, 35086.64913350834, 35149.47275790916, 25229.11698090558, 25639.871800640878, 25660.101896433534, 26300.605490917267, 26327.473450531266], "value": 20331.721575183426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.6183024680569, 362.99637003629965, 374.501912456433, 376.71369758983167, 396.2985515637322, 18959.33642322519, 19412.320568780095, 19641.116149773257, 19688.704669429953, 19939.800601993975, 19257.037148142572, 19434.0, 19667.606647867033, 19711.211551537956, 19891.30380436685, 4872.342233798445, 5519.530839878606, 5841.85395365115, 5842.47417732404, 5864.912026319608, 5626.0, 5694.003549378863, 5751.281089863767, 5760.62555933865, 5765.538756899459, 5416.702081385522, 5649.830505084834, 5733.283339582552, 5744.913826292609, 5776.162456443813, 5625.662460252377, 5663.745131469093, 5671.6597004179885, 5676.148577713335, 5676.545876329925, 4723.220668589679, 4888.657793954425, 4930.679505832145, 4946.084974279734, 4949.480304568005, 24005.27984160478, 24111.397215069588, 24133.87933060341, 24149.7585024151, 24304.270871873694, 2383.9284821455385, 2403.6034054381007, 2581.7805486533666, 2595.5198288316533, 2834.9291267718268, 14310.85689143116, 14477.42090316386, 14869.330880110421, 14949.775753363709, 15456.149911754848, 1777.8222177782247, 1807.0874208524742, 1817.009729697318, 1828.7988321284647, 1861.1810803246663, 77889.0, 100253.0, 101588.46028849264, 103295.48352258191, 104304.0, 8107.716229931924, 10010.449425281533, 10109.797804043877, 10133.240006999504, 10408.947955260175, 10093.343932644355, 10937.671869843918, 12742.745145097231, 12786.360681965865, 12848.743025139445, 6628.5691430056895, 8066.83866322682, 8215.301699355503, 8352.665893364197, 8362.874556881652, 8230.300424463869, 8288.544130072783, 8342.916570834213, 8386.245237928615, 8520.105388934073, 6071.574989750675, 6185.752569897154, 6220.284667263322, 6260.968695156495, 6315.115883776275, 1793.5964408008094, 1823.5988082621802, 1847.353426300784, 1852.3146435818833, 1860.1071485686675, 904.4392476664378, 927.9977624165884, 929.6746138851483, 988.5502096546054, 998.2463240253562, 16196.838031619769, 19547.706784398244, 20860.269890553758, 21263.468413289484, 21295.36113916585, 882.2677177942293, 908.1644886704248, 965.6958058211641, 968.3124981263242, 1010.3988127064385, 10374.377537347784, 10461.895381046092, 10557.788844223072, 11159.553617855196, 11254.381009044417, 521320.0, 528522.0, 529694.3515282399, 536770.0, 544699.0, 96389.51805240929, 133676.0, 135656.0, 139810.0, 141454.29272853775, 924.306769922558, 955.9617615295449, 968.3512046928574, 993.0913214408735, 996.880374355082, 14082.22547759842, 17718.11409429549, 18050.548736281697, 18265.178066987282, 18686.53283667865, 37174.442383363734, 50794.74602626963, 51224.74387628038, 55097.0, 56393.71803140958, 54080.72959635334, 68399.65800170967, 70275.0, 71168.64415677889, 71817.0, 7504.174540800398, 7511.286427789351, 7705.9211710361715, 7788.766337009899, 8022.638981245741, 8702.782430439036, 9158.175764181256, 12356.25862448256, 12399.690007749878, 12483.251004939733, 10238.795224095327, 10484.895151048391, 10752.193585480964, 10864.945675271572, 11003.779924401308, 10198.592056317664, 10598.31110977784, 10661.786764264827, 10804.405757683402, 10958.890411095786, 10265.076143147153, 10430.791384172426, 10807.0, 11160.386178760245, 11245.606403776155, 7616.162222155669, 7801.4929029612895, 7851.60741962911, 7905.209479052049, 7979.321757650432, 9690.127888489787, 10728.570857165938, 11011.504482298156, 11046.944765276123, 11171.72070698239], "value": 9264.077843602563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.2673190136834, 1526.9083854968703, 1786.187284785422, 1892.7539419875413, 1936.7869534351219, 7917.960410197941, 8162.795930101735, 8411.705590304333, 9001.414908030973, 9018.95490522548, 6539.0, 8668.73993780186, 8682.739517814476, 8775.385722999377, 8785.0, 2348.988255058722, 2366.0535785685693, 2366.9408264793346, 2372.098602531036, 2378.0606660369144, 2344.7069116360453, 2349.001674288429, 2377.227401094651, 2384.654225137354, 2391.4021494626345, 2346.9061237550477, 2359.9882000589973, 2368.5973384524586, 2372.323887692008, 2377.263048454976, 2324.0471406723163, 2332.078828862598, 2335.8364914455997, 2344.78896899279, 2368.182976872993, 2054.5582699719484, 2143.767333783081, 2321.8490798098237, 2326.3835083702834, 2341.5785158671433, 8840.071792461827, 8871.467711937305, 8877.467351958903, 8907.910920890772, 8983.910160898373, 5237.973810130925, 5246.449122842123, 5347.957148356072, 5395.865103372408, 5440.102383106782, 3483.2685136121445, 3507.2810073934784, 3602.1534939289245, 3610.2238018825815, 3645.7447978641508, 1010.5099026971913, 1044.7701505668817, 1046.9162467002698, 1063.239783554762, 1069.7806949575318, 11496.827547586709, 11534.59628912984, 11619.941900290529, 11635.941820290844, 11644.88355116455, 4003.839846406111, 4530.935230220895, 4736.313234580966, 4835.685680430761, 4838.879028024327, 9796.755081122887, 9812.82246130469, 9871.703848884401, 9883.703488895344, 9888.110070093582, 5380.112281473591, 5398.109311963561, 5404.270423492857, 5410.48600382963, 5412.296401467863, 3652.817359132086, 4572.154151481986, 4694.765261736899, 4877.170880950247, 4962.851114466572, 3913.1391093959282, 3950.486436763202, 4035.233305671913, 4048.3927410888014, 4083.612056854594, 1121.433675993618, 1318.1893135721655, 1327.1042046618493, 1339.136257114156, 1351.7566837969064, 799.9241020826978, 908.5094049213351, 918.5453200665713, 929.665320484625, 969.9718298603503, 5575.581831362664, 5847.707614619252, 5877.941970445361, 5956.195913551615, 6067.150598916155, 373.25349301397205, 451.64094544836934, 453.57590652739793, 880.1858281089966, 978.5498670611456, 3778.6221377861993, 3906.9609303907164, 3932.292187406237, 4000.9797501636895, 4006.1186538961383, 10248.948755256177, 10548.736281593021, 10554.525046372932, 10556.997085276886, 10560.788784224425, 9939.50302484873, 10491.895081049244, 10531.52608132636, 10553.788924221473, 10596.470176491144, 7916.366690664733, 8121.959390203011, 8128.349732021424, 8147.226013528705, 8183.631736571869, 5181.0, 5219.9217011744095, 5417.458254174551, 5444.455554444524, 6259.280182778856, 9498.19265362452, 9901.55443005052, 9953.402795832273, 9968.900310997087, 9970.900290997288, 9178.541072946193, 9335.25317974574, 9634.614615415305, 9984.101430871257, 10147.746306342106, 7258.3104605062435, 7285.744998925013, 7289.854202915806, 7335.4498412618195, 7378.077740282465, 7957.920420795718, 8009.399295053011, 8040.195980402147, 8048.356131509348, 8052.993375828021, 7144.64276786169, 7230.783076507713, 7253.347198751927, 7331.4134869209265, 7357.484976051625, 7129.287071293037, 7146.285371462812, 7172.318629730167, 7213.242609525924, 7266.600336981305, 5257.868553286198, 5785.0, 6287.842803929939, 6878.105846239957, 6915.03189553473, 4523.932141017953, 4718.7168769873915, 4849.4908034655855, 4930.8767280818265, 4983.377077865267, 4313.525512193593, 4744.288356746516, 4853.174960256835, 4987.326710893983, 5130.897382052263], "value": 4474.665423001951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8096208907343, 301.9109362737992, 308.2924687841403, 311.982840943748, 313.7192212969392, 5009.0, 5245.554127899133, 5507.476789704977, 5533.91699124513, 5548.4451554844545, 4702.90594188116, 5278.551323137528, 5284.603654725892, 5348.786048558053, 5403.46001389603, 3580.319739249547, 3871.935217815102, 4139.730917490354, 4144.48193975753, 4158.8960275993195, 3082.830444325561, 3616.0, 3742.7754334739866, 4161.750294982296, 4165.791710414483, 3524.1189702574356, 3966.6033396660246, 4066.06480509483, 4105.651019663333, 4111.923478643281, 4094.467719196515, 4105.486814148231, 4113.4035564843225, 4127.688494443121, 4134.4831896013, 3578.481120237577, 3585.103724068983, 3593.2094939113354, 3599.3521166190076, 3614.27714457107, 4837.0, 5043.764277751938, 5242.453476224523, 5289.44460831611, 5292.550133238679, 4511.639068874482, 4722.693024953367, 4768.284757286435, 4770.76146192689, 4776.546228108359, 4612.746298953556, 5083.805305753145, 5626.24314086099, 5683.7034519978315, 5755.827325180251, 3167.635721891989, 3567.1795487037866, 3625.401808701561, 3726.757760745543, 3958.7228893977435, 5238.030964271622, 5507.870886468264, 6148.986996371746, 6154.384561543855, 6178.270084376381, 3168.683131686813, 3279.8524066417067, 3443.8794642187904, 3817.9618203818163, 3993.84024639017, 3154.227214332503, 3361.83190840457, 3387.932241355159, 4004.6395824375945, 4054.8378064877666, 3536.504889315498, 4205.852795152155, 4529.728216307032, 4709.293605959134, 4709.317149013443, 4370.2352088384405, 4918.401519506175, 5391.595630327741, 5781.53747700183, 5867.301041520863, 1279.3475327583, 1322.5305016718926, 1322.8280323557876, 1340.2963444191682, 1352.3238380809596, 743.1008479739576, 757.3297631596078, 906.7461110888962, 919.1681528216974, 920.7191806498948, 4329.069250111241, 5311.893762124736, 5416.377116631559, 5493.972530137324, 5512.39363669996, 5144.408393034774, 5266.525372895595, 5492.093804522209, 5933.520192254906, 5954.46409823118, 5158.280044975173, 5424.915016996538, 5441.619086663895, 5446.319210098738, 5458.590605704588, 2521.344450442898, 2538.327343254039, 2662.3610333519814, 2673.4493993483734, 2677.7857771378244, 4725.432948046257, 5171.629518177686, 5172.810253641684, 5225.634205605571, 5244.306345820545, 4370.935030421739, 4656.301554766812, 5029.5221953914315, 5793.0, 6077.229374940739, 5578.748956296895, 6195.504359651217, 6243.719032643542, 6289.654069026247, 6314.0, 4858.489858564941, 5757.0, 5947.375525569752, 6021.7591296347655, 6079.361667024898, 4727.9669742011265, 5253.737313134252, 5351.5718742501285, 5671.092625179951, 6003.279606447254, 5867.471927526543, 6242.252169392577, 6293.370662933853, 6299.236213860127, 6316.336784637547, 3941.4481972523295, 4057.107436363995, 4083.244599749056, 4111.342185250345, 4127.442795222607, 5649.22049554389, 5905.143754155709, 5934.643921364732, 5973.223480947449, 5982.0, 4363.520012798526, 5229.869253268546, 5739.8565035874435, 5890.381509941566, 5895.852603684771, 4821.6383771218, 5344.652597581145, 5635.549156067586, 5873.825234952941, 5978.701064946648, 4589.678722489393, 5650.0959846424375, 5719.8856022880145, 5736.913946290892, 5770.769169233352, 5824.5340372770925, 5831.329397119385, 5839.416058394127, 5893.528517718658, 5906.586538942404, 4850.53919877611, 5575.581831362745, 5699.808107459836, 5761.48146666802, 5767.423257674199], "value": 4094.237719880509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.8607706304614, 720.9423246140308, 724.8803947348688, 747.1482509938671, 781.9100803407609, 15178.31697573609, 15659.295331710073, 16135.43525976591, 16136.999999999985, 16183.0, 14521.49174778883, 14688.118712877234, 14701.852981470181, 14703.852961470382, 14711.0, 701.1901254051579, 720.7225218290944, 874.7419511244167, 877.8376000439907, 899.0245583541865, 899.6761165980274, 905.2260317428603, 905.710172744722, 910.0399078971682, 912.803747194353, 947.6493697331997, 967.4920666649995, 969.7624082099895, 970.4419958523841, 973.2068364283086, 959.2230293462283, 962.4417837654144, 962.7256231973854, 964.1900803325206, 964.5948701545368, 702.4906942466722, 713.6467448612918, 715.2239819795528, 716.4340171264695, 719.2088702427341, 14463.20452375119, 14627.63430914225, 14797.778033329509, 14837.629059273497, 14847.777283340758, 14374.425022999067, 14444.422223111063, 14511.564653060424, 14617.853821461755, 14828.481003164838, 11890.464929078125, 11911.821322680167, 11929.28424294545, 12009.879901200964, 12192.451339689735, 3741.2143449875557, 3885.106425522146, 3888.9611103889165, 3919.98040009801, 3922.5685174630767, 112873.0, 115947.42026289814, 116055.83944160535, 116116.99999999916, 116683.0, 11130.49912753928, 11136.38749868765, 11136.944315278372, 11173.72065698364, 11620.244684095507, 18470.445886623424, 19059.714104288447, 22897.08411663515, 23064.4233894154, 23096.538069238522, 6790.354916282945, 7963.442559020813, 8031.518108913484, 8187.345012399113, 8303.211194936472, 4454.532274111171, 4467.798949047301, 4516.570925762047, 4519.683622146418, 4590.472095709036, 3599.2261663741897, 3669.486271921933, 3721.7953012584026, 3723.1436769542615, 3724.845297957642, 592.691800263869, 657.9868402631921, 659.9571027883172, 671.660811290305, 673.9865202695919, 524.7586110389263, 560.436761055137, 569.6809786519563, 653.4543656047254, 700.6601798128006, 9100.772480688036, 9252.420749423087, 9434.811303774024, 9437.197838183694, 9442.38624489406, 582.0570675505708, 594.9345571987078, 642.4667525953447, 660.7918505670698, 667.7896462614261, 3893.805309734502, 4434.467863856358, 4499.257622492252, 4534.79593418297, 4556.430446194226, 83305.58347208225, 84174.0, 105403.41894871583, 153111.2344438293, 157241.0, 140697.0, 142557.28721356328, 143589.28205358906, 143682.0, 143812.28093859673, 70918.64540677263, 71106.64446677837, 74161.6291918537, 118191.81808181808, 125166.12250816062, 8699.81690372714, 8830.514321712368, 8876.778080548038, 8900.554972251492, 8930.464172149692, 49634.75182624064, 64725.0, 65122.34877651163, 65682.01476977945, 66896.0, 96489.0, 99619.0, 101302.0, 102753.0, 104683.4765826166, 11818.881811182122, 11970.76058478843, 12005.699857503632, 12492.375991121096, 12576.371181441074, 10684.252102353072, 10745.785084298426, 12727.918126959312, 12894.48422063107, 13108.0, 9652.324337296322, 11729.47217375203, 11845.0, 11997.76004479888, 12410.379481025731, 12037.03703703684, 12153.81769273444, 12212.389380531116, 12330.81503777462, 12649.93675031619, 11772.411379430823, 11782.116341274268, 11908.464119114833, 12361.752764944831, 12370.13409061393, 9332.30007749408, 9559.996200398858, 10325.63860264887, 10340.0, 10507.89492105069, 9607.855882161633, 10074.899251007397, 10216.284860059724, 10267.973202679672, 10391.428471434143], "value": 7650.546651978886, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 124.0, 100.0, 175.0, 170.0, 173.0, 118.0, 122.0, 177.0], "value": 139.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 114.0, 168.0, 151.0, 148.0, 136.0, 118.0, 144.0, 117.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 212.0, 245.0, 272.0, 198.0, 198.0, 199.0, 198.0, 194.0, 196.0], "value": 211.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 89.0, 59.0, 69.0, 59.0, 59.0, 81.0, 60.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 87.0, 74.0, 69.0, 71.0, 89.0, 70.0, 68.0, 83.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 89.0, 87.0, 91.0, 86.0, 90.0, 88.0, 89.0, 105.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 98.0, 154.0, 118.0, 95.0, 95.0, 94.0, 98.0, 106.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 89.0, 104.0, 124.0, 127.0, 90.0, 116.0, 146.0, 78.0, 134.0], "value": 110.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 58.0, 59.0, 60.0, 58.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 78.0, 75.0, 108.0, 71.0, 78.0, 104.0, 106.0, 109.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 97.0, 87.0, 78.0, 102.0, 113.0, 88.0, 89.0, 91.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 159.0, 135.0, 153.0, 149.0, 149.0, 147.0, 207.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 173.0, 176.0, 178.0, 176.0, 177.0, 178.0, 173.0, 186.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 73.0, 71.0, 84.0, 81.0, 71.0, 71.0], "value": 72.6, "unit": "score"}]}]} 03:29:33 INFO - Return code: 0 03:29:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:29:33 ERROR - # TBPL SUCCESS # 03:29:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:33 INFO - 2016-10-15 03:29:33.788 screenresolution[1974:24365] starting screenresolution argv=screenresolution get 03:29:33 INFO - 2016-10-15 03:29:33.793 screenresolution[1974:24365] Display 0: 1600x1200x32@60 03:29:33 INFO - 2016-10-15 03:29:33.799 screenresolution[1975:24368] starting screenresolution argv=screenresolution list 03:29:33 INFO - Available Modes on Display 0 03:29:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:34 INFO - Intel Iris: 03:29:34 INFO - Chipset Model: Intel Iris 03:29:34 INFO - Type: GPU 03:29:34 INFO - Bus: Built-In 03:29:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:34 INFO - Vendor: Intel (0x8086) 03:29:34 INFO - Device ID: 0x0a2e 03:29:34 INFO - Revision ID: 0x0009 03:29:34 INFO - Displays: 03:29:34 INFO - Display: 03:29:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:34 INFO - Display Serial Number: 1600x1200 60 03:29:34 INFO - Main Display: Yes 03:29:34 INFO - Mirror: Off 03:29:34 INFO - Online: Yes 03:29:34 INFO - Rotation: Supported 03:29:34 INFO - Return code: 0 03:29:34 INFO - Running post-action listener: _resource_record_post_action 03:29:34 INFO - [mozharness: 2016-10-15 10:29:34.042792Z] Finished run-tests step (success) 03:29:34 INFO - Running post-run listener: _resource_record_post_run 03:29:34 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 424960; Write bytes: 715014144; Read time: 17; Write time: 2030 03:29:34 INFO - TinderboxPrint: CPU usage
54.5% 03:29:34 INFO - TinderboxPrint: I/O read bytes / time
424,960 / 17 03:29:34 INFO - TinderboxPrint: I/O write bytes / time
715,014,144 / 2,030 03:29:34 INFO - TinderboxPrint: CPU idle
2,208.5 (45.5%) 03:29:34 INFO - TinderboxPrint: CPU system
982.7 (20.3%) 03:29:34 INFO - TinderboxPrint: CPU user
1,658.6 (34.2%) 03:29:34 INFO - TinderboxPrint: Swap in / out
407,764,992 / 0 03:29:34 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394809856; Write bytes: 390370816; Read time: 29252; Write time: 783 03:29:34 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 424960; Write bytes: 302991872; Read time: 17; Write time: 1177 03:29:34 INFO - Running post-run listener: _upload_blobber_files 03:29:34 INFO - Blob upload gear active. 03:29:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:29:34 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 03:29:34 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'] 03:29:34 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 03:29:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:35 INFO - (blobuploader) - INFO - Done attempting. 03:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:36 INFO - (blobuploader) - INFO - Done attempting. 03:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:29:38 INFO - (blobuploader) - INFO - Done attempting. 03:29:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:29:38 INFO - Return code: 0 03:29:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:29:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:29:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1abcc353fc5a277a4ffb293a9868c5bb09db62c4b7fcd5628b40615d6f25ee3306c28deaaae45b0e45baa497e51fbdc2421f405f3ce9a25eabaf4d65af545d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cc21f680cb90819e4931cd34f7a5b0641e53d583363e781b5748a2926481e1a0fdd8dd23a6823c4b16b7ba9be4ca9ecafd04591c88b75494fc5f9dc6970ca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e3a0eafacc7ba5ece7ff882f63c5afb3436def9c577791ed483427848659d26cbefeb93b4e678578e2158df6d3bda95642e8c0baad7e7d3864281b1a095291"} 03:29:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:29:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:29:38 INFO - Contents: 03:29:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1abcc353fc5a277a4ffb293a9868c5bb09db62c4b7fcd5628b40615d6f25ee3306c28deaaae45b0e45baa497e51fbdc2421f405f3ce9a25eabaf4d65af545d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cc21f680cb90819e4931cd34f7a5b0641e53d583363e781b5748a2926481e1a0fdd8dd23a6823c4b16b7ba9be4ca9ecafd04591c88b75494fc5f9dc6970ca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e3a0eafacc7ba5ece7ff882f63c5afb3436def9c577791ed483427848659d26cbefeb93b4e678578e2158df6d3bda95642e8c0baad7e7d3864281b1a095291"} 03:29:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:29:38 INFO - Copying logs to upload dir... 03:29:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:29:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.662782 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-15 03:29:38.955058) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:29:38.958214) ========= 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.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/d1abcc353fc5a277a4ffb293a9868c5bb09db62c4b7fcd5628b40615d6f25ee3306c28deaaae45b0e45baa497e51fbdc2421f405f3ce9a25eabaf4d65af545d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cc21f680cb90819e4931cd34f7a5b0641e53d583363e781b5748a2926481e1a0fdd8dd23a6823c4b16b7ba9be4ca9ecafd04591c88b75494fc5f9dc6970ca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e3a0eafacc7ba5ece7ff882f63c5afb3436def9c577791ed483427848659d26cbefeb93b4e678578e2158df6d3bda95642e8c0baad7e7d3864281b1a095291"} build_url:https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/Ke8e8v-jSq-1Ijc8thg8Yg/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/d1abcc353fc5a277a4ffb293a9868c5bb09db62c4b7fcd5628b40615d6f25ee3306c28deaaae45b0e45baa497e51fbdc2421f405f3ce9a25eabaf4d65af545d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cc21f680cb90819e4931cd34f7a5b0641e53d583363e781b5748a2926481e1a0fdd8dd23a6823c4b16b7ba9be4ca9ecafd04591c88b75494fc5f9dc6970ca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e3a0eafacc7ba5ece7ff882f63c5afb3436def9c577791ed483427848659d26cbefeb93b4e678578e2158df6d3bda95642e8c0baad7e7d3864281b1a095291"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:29:38.991399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:29:38.991748) ========= 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.uUqLUHpMeO/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.JUv00mt8wb/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005046 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:29:39.042520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:29:39.043111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:29:39.043805) ========= ========= Total master_lag: 0.21 =========