builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0032 starttime: 1477515294.87 results: success (0) buildid: 20161011025846 builduid: 5120a331d5884b248fd298482f4fffa2 revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.872772) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.873208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.873495) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.897356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.897627) ========= 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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-26 13:54:54-- 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% 9.68M=0.001s 2016-10-26 13:54:54 (9.68 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.997113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:54.997465) ========= 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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026114 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:55.046441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:54:55.046903) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --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 45052ddb03a448606ca6ce33f4893a559edebf72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-26 13:54:55,122 truncating revision to first 12 chars 2016-10-26 13:54:55,122 Setting DEBUG logging. 2016-10-26 13:54:55,123 attempt 1/10 2016-10-26 13:54:55,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45052ddb03a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:54:55,876 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.003696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:54:56.072363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:56.072678) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:56.073076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:56.073361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:54:56.091234) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-10-26 13:54:56.091504) ========= /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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:54:56 INFO - MultiFileLogger online at 20161026 13:54:56 in /builds/slave/test 13:54:56 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 13:54:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:54:56 INFO - {'append_to_log': False, 13:54:56 INFO - 'base_work_dir': '/builds/slave/test', 13:54:56 INFO - 'blob_upload_branch': 'Firefox', 13:54:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:54:56 INFO - 'branch': 'Firefox', 13:54:56 INFO - 'buildbot_json_path': 'buildprops.json', 13:54:56 INFO - 'config_files': ('talos/mac_config.py',), 13:54:56 INFO - 'default_actions': ('clobber', 13:54:56 INFO - 'read-buildbot-config', 13:54:56 INFO - 'download-and-extract', 13:54:56 INFO - 'populate-webroot', 13:54:56 INFO - 'create-virtualenv', 13:54:56 INFO - 'install', 13:54:56 INFO - 'run-tests'), 13:54:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:54:56 INFO - 'download_minidump_stackwalk': True, 13:54:56 INFO - 'download_symbols': 'ondemand', 13:54:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:54:56 INFO - 'tooltool.py': '/tools/tooltool.py', 13:54:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:54:56 INFO - '/tools/misc-python/virtualenv.py')}, 13:54:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:54:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:54:56 INFO - 'installer_path': 'installer.exe', 13:54:56 INFO - 'log_level': 'info', 13:54:56 INFO - 'log_name': 'talos', 13:54:56 INFO - 'log_to_console': True, 13:54:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:54:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:54:56 INFO - 'opt_config_files': (), 13:54:56 INFO - 'pip_index': False, 13:54:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:54:56 INFO - 'cmd': ('bash', 13:54:56 INFO - '-c', 13:54:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:54:56 INFO - 'enabled': True, 13:54:56 INFO - 'halt_on_failure': False, 13:54:56 INFO - 'name': 'check_screen_resolution'},), 13:54:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:54:56 INFO - 'cmd': ('bash', 13:54:56 INFO - '-c', 13:54:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:54:56 INFO - 'enabled': True, 13:54:56 INFO - 'halt_on_failure': False, 13:54:56 INFO - 'name': 'check_screen_resolution'},), 13:54:56 INFO - 'run_cmd_checks_enabled': True, 13:54:56 INFO - 'sps_profile': False, 13:54:56 INFO - 'sps_profile_interval': 0, 13:54:56 INFO - 'suite': 'dromaeojs-e10s', 13:54:56 INFO - 'system_bits': '32', 13:54:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:54:56 INFO - 'title': 't-yosemite-r7-0032', 13:54:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:54:56 INFO - 'use_talos_json': True, 13:54:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:54:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:54:56 INFO - 'work_dir': 'build'} 13:54:56 INFO - [mozharness: 2016-10-26 20:54:56.294082Z] Running clobber step. 13:54:56 INFO - Running pre-action listener: _resource_record_pre_action 13:54:56 INFO - Running main action method: clobber 13:54:56 INFO - rmtree: /builds/slave/test/build 13:54:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:54:58 INFO - Running post-action listener: _resource_record_post_action 13:54:58 INFO - [mozharness: 2016-10-26 20:54:58.453308Z] Finished clobber step (success) 13:54:58 INFO - [mozharness: 2016-10-26 20:54:58.453545Z] Running read-buildbot-config step. 13:54:58 INFO - Running pre-action listener: _resource_record_pre_action 13:54:58 INFO - Running main action method: read_buildbot_config 13:54:58 INFO - Using buildbot properties: 13:54:58 INFO - { 13:54:58 INFO - "project": "", 13:54:58 INFO - "product": "firefox", 13:54:58 INFO - "script_repo_revision": "production", 13:54:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:54:58 INFO - "repository": "", 13:54:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:54:58 INFO - "buildid": "20161011025846", 13:54:58 INFO - "pgo_build": "False", 13:54:58 INFO - "basedir": "/builds/slave/test", 13:54:58 INFO - "buildnumber": 316, 13:54:58 INFO - "slavename": "t-yosemite-r7-0032", 13:54:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:54:58 INFO - "platform": "yosemite_r7", 13:54:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:54:58 INFO - "branch": "mozilla-central", 13:54:58 INFO - "repo_path": "mozilla-central", 13:54:58 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 13:54:58 INFO - "stage_platform": "macosx64", 13:54:58 INFO - "builduid": "5120a331d5884b248fd298482f4fffa2", 13:54:58 INFO - "slavebuilddir": "test" 13:54:58 INFO - } 13:54:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:54:58 INFO - Running post-action listener: _resource_record_post_action 13:54:58 INFO - [mozharness: 2016-10-26 20:54:58.459629Z] Finished read-buildbot-config step (success) 13:54:58 INFO - [mozharness: 2016-10-26 20:54:58.459846Z] Running download-and-extract step. 13:54:58 INFO - Running pre-action listener: _resource_record_pre_action 13:54:58 INFO - Running main action method: download_and_extract 13:54:58 INFO - mkdir: /builds/slave/test/build/tests 13:54: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')]} 13:54:58 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/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 13:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/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 13:55:04 INFO - Downloaded 1199 bytes. 13:55:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:55:04 INFO - Using the following test package requirements: 13:55:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:55:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:55:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'jsshell-mac.zip'], 13:55:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:55:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:55:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:55:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:55:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:55:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:55:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:55:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:55:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:55:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:08 INFO - Http code: 200 13:55:08 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:55:08 INFO - x-amz-cf-id: Osrde6wswLOCw4xsvBNEWLkuBik0biIfkRwY7AfsJlb2K2i5nSckaQ== 13:55:08 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:09 INFO - Expected file size: 16508481 13:55:09 INFO - Obtained file size: 16508481 13:55:15 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 13:55:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:55:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:55:15 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:55:16 INFO - Http code: 200 13:55:16 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:55:16 INFO - x-amz-cf-id: eo_ztHLvNqHYrgEuHnZeLCqX9Kj6kAeByouKMW05wAwBD_xVKZnvdg== 13:55:16 INFO - x-amz-version-id: CZxGqnprQt9hc3ZczjVjBynkkRCoui5n 13:55:16 INFO - Expected file size: 16508481 13:55:16 INFO - Obtained file size: 16508481 13:55:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:55:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:55:23 INFO - Fetch https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:55:24 INFO - Http code: 200 13:55:24 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 13:55:24 INFO - x-amz-cf-id: LW0kogv6Ulzsry5pKsTYtSp6Z4Q-FBDTzWYcWG7nHY7uJwUFNGIq3Q== 13:55:24 INFO - x-amz-version-id: h7oaKNhRQzyZtP5vdBlaq4n0FwksjilO 13:55:24 INFO - Expected file size: 14409006 13:55:24 INFO - Obtained file size: 14409006 13:55:24 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')]} 13:55:24 INFO - trying https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:24 INFO - Downloading https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/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 13:55:27 INFO - Downloaded 111738529 bytes. 13:55:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:27 INFO - mkdir: /builds/slave/test/properties 13:55:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:27 INFO - Contents: 13:55:27 INFO - build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:55:28 INFO - Running post-action listener: _resource_record_post_action 13:55:28 INFO - Running post-action listener: set_extra_try_arguments 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.866261Z] Finished download-and-extract step (success) 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.866409Z] Running populate-webroot step. 13:55:28 INFO - Running pre-action listener: _resource_record_pre_action 13:55:28 INFO - Running main action method: populate_webroot 13:55:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:28 INFO - '--tppagecycles', 13:55:28 INFO - '7'], 13:55:28 INFO - 'tests': ['tsvgm']}}, 13:55:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['damp', 'tps']}, 13:55:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['damp', 'tps']}, 13:55:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['dromaeo_dom']}, 13:55:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['basic_compositor_video']}, 13:55:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['a11yr', 13:55:28 INFO - 'ts_paint', 13:55:28 INFO - 'tpaint', 13:55:28 INFO - 'sessionrestore', 13:55:28 INFO - 'sessionrestore_no_auto_restore', 13:55:28 INFO - 'tabpaint']}, 13:55:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tsvgx', 13:55:28 INFO - 'tsvgr_opacity', 13:55:28 INFO - 'tart', 13:55:28 INFO - 'tscrollx', 13:55:28 INFO - 'cart']}, 13:55:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:28 INFO - 'tsvgr_opacity', 13:55:28 INFO - 'tart', 13:55:28 INFO - 'tscrollx', 13:55:28 INFO - 'cart']}, 13:55:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s'], 13:55:28 INFO - 'tests': ['tp5o']}, 13:55:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'tests': ['tp5o']}, 13:55:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--disable-e10s', 13:55:28 INFO - '--xperf_path', 13:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:28 INFO - 'tests': ['tp5n']}, 13:55:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:28 INFO - 'talos_options': ['--xperf_path', 13:55:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:28 INFO - 'tests': ['tp5n']}}, 13:55:28 INFO - 'talos.zip': {'path': '', 13:55:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:28 INFO - Running post-action listener: _resource_record_post_action 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.885105Z] Finished populate-webroot step (success) 13:55:28 INFO - [mozharness: 2016-10-26 20:55:28.885239Z] Running create-virtualenv step. 13:55:28 INFO - Running pre-action listener: _resource_record_pre_action 13:55:28 INFO - Running main action method: create_virtualenv 13:55:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:28 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 13:55:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:29 INFO - Using real prefix '/tools/python27' 13:55:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:32 INFO - Installing pip.................done. 13:55:32 INFO - Return code: 0 13:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:55:32 INFO - Reading from file tmpfile_stdout 13:55:32 INFO - Output received: 13:55:32 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) 13:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:32 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')]} 13:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 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')]} 13:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:32 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:32 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 13:55:32 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 13:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:32 INFO - 'HOME': '/Users/cltbld', 13:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:32 INFO - 'LOGNAME': 'cltbld', 13:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:32 INFO - 'MOZ_NO_REMOTE': '1', 13:55:32 INFO - 'NO_EM_RESTART': '1', 13:55:32 INFO - 'PAGER': '/bin/cat', 13:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:32 INFO - 'PWD': '/builds/slave/test', 13:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:32 INFO - 'SHELL': '/bin/bash', 13:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:32 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:32 INFO - 'USER': 'cltbld', 13:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:32 INFO - 'XPC_FLAGS': '0x0', 13:55:32 INFO - 'XPC_SERVICE_NAME': '0', 13:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:33 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 13:55:33 INFO - Cleaning up... 13:55:33 INFO - Return code: 0 13:55:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55:33 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')]} 13:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:33 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')]} 13:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:33 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:33 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 13:55:33 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 13:55:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:33 INFO - 'HOME': '/Users/cltbld', 13:55:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:33 INFO - 'LOGNAME': 'cltbld', 13:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:33 INFO - 'MOZ_NO_REMOTE': '1', 13:55:33 INFO - 'NO_EM_RESTART': '1', 13:55:33 INFO - 'PAGER': '/bin/cat', 13:55:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:33 INFO - 'PWD': '/builds/slave/test', 13:55:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:33 INFO - 'SHELL': '/bin/bash', 13:55:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:33 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:33 INFO - 'USER': 'cltbld', 13:55:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:33 INFO - 'XPC_FLAGS': '0x0', 13:55:33 INFO - 'XPC_SERVICE_NAME': '0', 13:55:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:33 INFO - Downloading/unpacking psutil>=3.1.1 13:55:33 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 13:55:33 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 13:55:33 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 13:55:33 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 13:55:33 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 13:55:33 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 13:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:36 INFO - Installing collected packages: psutil 13:55:36 INFO - Running setup.py install for psutil 13:55:36 INFO - building 'psutil._psutil_osx' extension 13:55:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:55:37 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 13:55:37 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 13:55:37 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 13:55:37 INFO - building 'psutil._psutil_posix' extension 13:55:37 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 13:55:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:55:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:55:37 INFO - ^ 13:55:37 INFO - 1 warning generated. 13:55:37 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 13:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:38 INFO - Successfully installed psutil 13:55:38 INFO - Cleaning up... 13:55:38 INFO - Return code: 0 13:55:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:38 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:38 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 13:55:38 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 13:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:38 INFO - 'HOME': '/Users/cltbld', 13:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:38 INFO - 'LOGNAME': 'cltbld', 13:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:38 INFO - 'MOZ_NO_REMOTE': '1', 13:55:38 INFO - 'NO_EM_RESTART': '1', 13:55:38 INFO - 'PAGER': '/bin/cat', 13:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:38 INFO - 'PWD': '/builds/slave/test', 13:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:38 INFO - 'SHELL': '/bin/bash', 13:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:38 INFO - 'USER': 'cltbld', 13:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:38 INFO - 'XPC_FLAGS': '0x0', 13:55:38 INFO - 'XPC_SERVICE_NAME': '0', 13:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:38 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 13:55:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:40 INFO - Installing collected packages: mozsystemmonitor 13:55:40 INFO - Running setup.py install for mozsystemmonitor 13:55:41 INFO - Successfully installed mozsystemmonitor 13:55:41 INFO - Cleaning up... 13:55:41 INFO - Return code: 0 13:55:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:41 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')]} 13:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:41 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')]} 13:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:41 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:41 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 13:55:41 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 13:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:41 INFO - 'HOME': '/Users/cltbld', 13:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:41 INFO - 'LOGNAME': 'cltbld', 13:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:41 INFO - 'MOZ_NO_REMOTE': '1', 13:55:41 INFO - 'NO_EM_RESTART': '1', 13:55:41 INFO - 'PAGER': '/bin/cat', 13:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:41 INFO - 'PWD': '/builds/slave/test', 13:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:41 INFO - 'SHELL': '/bin/bash', 13:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:41 INFO - 'USER': 'cltbld', 13:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:41 INFO - 'XPC_FLAGS': '0x0', 13:55:41 INFO - 'XPC_SERVICE_NAME': '0', 13:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:41 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 13:55:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:44 INFO - warning: no files found matching '*.txt' 13:55:44 INFO - no previously-included directories found matching 'build' 13:55:44 INFO - no previously-included directories found matching 'dist' 13:55:44 INFO - no previously-included directories found matching '.git*' 13:55:44 INFO - Installing collected packages: jsonschema, functools32 13:55:44 INFO - Running setup.py install for functools32 13:55:44 INFO - warning: no files found matching '*.txt' 13:55:44 INFO - no previously-included directories found matching 'build' 13:55:44 INFO - no previously-included directories found matching 'dist' 13:55:44 INFO - no previously-included directories found matching '.git*' 13:55:44 INFO - Successfully installed jsonschema functools32 13:55:44 INFO - Cleaning up... 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:44 INFO - 'HOME': '/Users/cltbld', 13:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PAGER': '/bin/cat', 13:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - 'XPC_FLAGS': '0x0', 13:55:44 INFO - 'XPC_SERVICE_NAME': '0', 13:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:44 INFO - Cleaning up... 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:44 INFO - 'HOME': '/Users/cltbld', 13:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PAGER': '/bin/cat', 13:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - 'XPC_FLAGS': '0x0', 13:55:44 INFO - 'XPC_SERVICE_NAME': '0', 13:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:45 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 13:55:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 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 13:55:48 INFO - Downloading docopt-0.6.1.tar.gz 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:49 INFO - Running setup.py install for blobuploader 13:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:49 INFO - Running setup.py install for requests 13:55:49 INFO - Running setup.py install for docopt 13:55:49 INFO - Successfully installed blobuploader requests docopt 13:55:49 INFO - Cleaning up... 13:55:49 INFO - Return code: 0 13:55:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:49 INFO - 'HOME': '/Users/cltbld', 13:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:49 INFO - 'LOGNAME': 'cltbld', 13:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:49 INFO - 'MOZ_NO_REMOTE': '1', 13:55:49 INFO - 'NO_EM_RESTART': '1', 13:55:49 INFO - 'PAGER': '/bin/cat', 13:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:49 INFO - 'PWD': '/builds/slave/test', 13:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:49 INFO - 'SHELL': '/bin/bash', 13:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:49 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:49 INFO - 'USER': 'cltbld', 13:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:49 INFO - 'XPC_FLAGS': '0x0', 13:55:49 INFO - 'XPC_SERVICE_NAME': '0', 13:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-rK2r5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bSRLWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-z2FcLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AcjMqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-nRut5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EXav6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AgljFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-UeCwf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-k1qWqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-9QZCoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EPXOVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-53pJbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EBxQbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_qswOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-V32KTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-O5bmjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:51 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yloXTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:52 INFO - Running setup.py install for manifestparser 13:55:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozcrash 13:55:52 INFO - Running setup.py install for mozdebug 13:55:52 INFO - Running setup.py install for mozdevice 13:55:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozfile 13:55:52 INFO - Running setup.py install for mozhttpd 13:55:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:52 INFO - Running setup.py install for mozinfo 13:55:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozInstall 13:55:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozleak 13:55:53 INFO - Running setup.py install for mozlog 13:55:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for moznetwork 13:55:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozprocess 13:55:53 INFO - Running setup.py install for mozprofile 13:55:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:53 INFO - Running setup.py install for mozrunner 13:55:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozscreenshot 13:55:54 INFO - Running setup.py install for moztest 13:55:54 INFO - Running setup.py install for mozversion 13:55:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:54 INFO - Cleaning up... 13:55:54 INFO - Return code: 0 13:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 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')]} 13:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:55 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:55:55 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 13:55:55 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 13:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:55 INFO - 'HOME': '/Users/cltbld', 13:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:55 INFO - 'LOGNAME': 'cltbld', 13:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:55 INFO - 'MOZ_NO_REMOTE': '1', 13:55:55 INFO - 'NO_EM_RESTART': '1', 13:55:55 INFO - 'PAGER': '/bin/cat', 13:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:55 INFO - 'PWD': '/builds/slave/test', 13:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:55 INFO - 'SHELL': '/bin/bash', 13:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:55:55 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:55 INFO - 'USER': 'cltbld', 13:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:55 INFO - 'XPC_FLAGS': '0x0', 13:55:55 INFO - 'XPC_SERVICE_NAME': '0', 13:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cuDBSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:55 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)) 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-okKazv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:55 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)) 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-S6Znyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:55 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)) 13:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:55 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-urBZUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vJQXzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-XioYA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-dClbr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tJTLlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-x6bUE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-QeIHr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-H92GaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-b5u_FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:56 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-jQVgiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-z9tbIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yuxYZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:57 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cTQSWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:57 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3QFcpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:00 INFO - Downloading blessings-1.6.tar.gz 13:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:56:00 INFO - Installing collected packages: blessings 13:56:00 INFO - Running setup.py install for blessings 13:56:00 INFO - Successfully installed blessings 13:56:00 INFO - Cleaning up... 13:56:00 INFO - Return code: 0 13:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:01 INFO - Reading from file tmpfile_stdout 13:56:01 INFO - Current package versions: 13:56:01 INFO - blessings == 1.6 13:56:01 INFO - blobuploader == 1.2.4 13:56:01 INFO - docopt == 0.6.1 13:56:01 INFO - functools32 == 3.2.3-2 13:56:01 INFO - jsonschema == 2.5.1 13:56:01 INFO - manifestparser == 1.1 13:56:01 INFO - mozInstall == 1.12 13:56:01 INFO - mozcrash == 0.17 13:56:01 INFO - mozdebug == 0.1 13:56:01 INFO - mozdevice == 0.48 13:56:01 INFO - mozfile == 1.2 13:56:01 INFO - mozhttpd == 0.7 13:56:01 INFO - mozinfo == 0.9 13:56:01 INFO - mozleak == 0.1 13:56:01 INFO - mozlog == 3.4 13:56:01 INFO - moznetwork == 0.27 13:56:01 INFO - mozprocess == 0.23 13:56:01 INFO - mozprofile == 0.28 13:56:01 INFO - mozrunner == 6.12 13:56:01 INFO - mozscreenshot == 0.1 13:56:01 INFO - mozsystemmonitor == 0.3 13:56:01 INFO - moztest == 0.7 13:56:01 INFO - mozversion == 1.4 13:56:01 INFO - psutil == 3.1.1 13:56:01 INFO - requests == 1.2.3 13:56:01 INFO - wsgiref == 0.1.2 13:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:01 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 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:56:01 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 13:56:01 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 13:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:01 INFO - 'HOME': '/Users/cltbld', 13:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:01 INFO - 'LOGNAME': 'cltbld', 13:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:01 INFO - 'MOZ_NO_REMOTE': '1', 13:56:01 INFO - 'NO_EM_RESTART': '1', 13:56:01 INFO - 'PAGER': '/bin/cat', 13:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:01 INFO - 'PWD': '/builds/slave/test', 13:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:01 INFO - 'SHELL': '/bin/bash', 13:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:56:01 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:01 INFO - 'USER': 'cltbld', 13:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:01 INFO - 'XPC_FLAGS': '0x0', 13:56:01 INFO - 'XPC_SERVICE_NAME': '0', 13:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 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)) 13:56:01 INFO - Cleaning up... 13:56:01 INFO - Return code: 0 13:56:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101c65490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfa569620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, '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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:56: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'] in /builds/slave/test/build 13:56: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 13:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:01 INFO - 'HOME': '/Users/cltbld', 13:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:01 INFO - 'LOGNAME': 'cltbld', 13:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:01 INFO - 'MOZ_NO_REMOTE': '1', 13:56:01 INFO - 'NO_EM_RESTART': '1', 13:56:01 INFO - 'PAGER': '/bin/cat', 13:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:01 INFO - 'PWD': '/builds/slave/test', 13:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:01 INFO - 'SHELL': '/bin/bash', 13:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:56:01 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:01 INFO - 'USER': 'cltbld', 13:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:01 INFO - 'XPC_FLAGS': '0x0', 13:56:01 INFO - 'XPC_SERVICE_NAME': '0', 13:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:56:01 INFO - Cleaning up... 13:56:01 INFO - Return code: 0 13:56:01 INFO - Running post-action listener: _resource_record_post_action 13:56:01 INFO - Running post-action listener: _start_resource_monitoring 13:56:01 INFO - Starting resource monitoring. 13:56:01 INFO - [mozharness: 2016-10-26 20:56:01.633640Z] Finished create-virtualenv step (success) 13:56:01 INFO - [mozharness: 2016-10-26 20:56:01.634604Z] Running install step. 13:56:01 INFO - Running pre-action listener: _resource_record_pre_action 13:56:01 INFO - Running main action method: install 13:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:01 INFO - Reading from file tmpfile_stdout 13:56:01 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:01 INFO - Reading from file tmpfile_stdout 13:56:01 INFO - Output received: 13:56:01 INFO - Usage: mozinstall [options] installer 13:56:01 INFO - Options: 13:56:01 INFO - -h, --help show this help message and exit 13:56:01 INFO - -d DEST, --destination=DEST 13:56:01 INFO - Directory to install application into. [default: 13:56:01 INFO - "/builds/slave/test"] 13:56:01 INFO - --app=APP Application being installed. [default: firefox] 13:56:01 INFO - mkdir: /builds/slave/test/build/application 13:56:01 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'] 13:56:01 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 13:56:36 INFO - Reading from file tmpfile_stdout 13:56:36 INFO - Output received: 13:56:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:56:36 INFO - Running post-action listener: _resource_record_post_action 13:56:36 INFO - [mozharness: 2016-10-26 20:56:36.718486Z] Finished install step (success) 13:56:36 INFO - [mozharness: 2016-10-26 20:56:36.718616Z] Running run-tests step. 13:56:36 INFO - Running pre-action listener: _resource_record_pre_action 13:56:36 INFO - Running main action method: run_tests 13:56:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:36 INFO - 2016-10-26 13:56:36.733 screenresolution[1644:7724] starting screenresolution argv=screenresolution get 13:56:36 INFO - 2016-10-26 13:56:36.736 screenresolution[1644:7724] Display 0: 1600x1200x32@60 13:56:36 INFO - 2016-10-26 13:56:36.742 screenresolution[1645:7726] starting screenresolution argv=screenresolution list 13:56:36 INFO - Available Modes on Display 0 13:56:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:36 INFO - Intel Iris: 13:56:36 INFO - Chipset Model: Intel Iris 13:56:36 INFO - Type: GPU 13:56:36 INFO - Bus: Built-In 13:56:36 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:36 INFO - Vendor: Intel (0x8086) 13:56:36 INFO - Device ID: 0x0a2e 13:56:36 INFO - Revision ID: 0x0009 13:56:36 INFO - Displays: 13:56:36 INFO - Display: 13:56:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:36 INFO - Display Serial Number: 1600x1200 60 13:56:36 INFO - Main Display: Yes 13:56:36 INFO - Mirror: Off 13:56:36 INFO - Online: Yes 13:56:36 INFO - Rotation: Supported 13:56:36 INFO - Return code: 0 13:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:36 INFO - Python 2.7.3 13:56:36 INFO - Return code: 0 13:56:36 INFO - grabbing minidump binary from tooltool 13:56:36 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')]} 13:56:36 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 0x101a79d30>, '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 0x10189fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a71b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:36 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 13:56:36 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 13:56:36 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 13:56:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:37 INFO - Return code: 0 13:56:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:56:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:56:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:37 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/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 13:56:37 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/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 13:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r6ZXJiQZB8/Render', 13:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:37 INFO - 'HOME': '/Users/cltbld', 13:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:37 INFO - 'LOGNAME': 'cltbld', 13:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:37 INFO - 'MOZ_NO_REMOTE': '1', 13:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:37 INFO - 'NO_EM_RESTART': '1', 13:56:37 INFO - 'PAGER': '/bin/cat', 13:56:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:37 INFO - 'PWD': '/builds/slave/test', 13:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:37 INFO - 'SHELL': '/bin/bash', 13:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kJtf05LuZm/Listeners', 13:56:37 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:37 INFO - 'USER': 'cltbld', 13:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:37 INFO - 'XPC_FLAGS': '0x0', 13:56:37 INFO - 'XPC_SERVICE_NAME': '0', 13:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:37 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/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 13:56:37 INFO - mozversion application_buildid: 20161011025846 13:56:37 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:37 INFO - mozversion application_display_name: Nightly 13:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:37 INFO - mozversion application_name: Firefox 13:56:37 INFO - mozversion application_remotingname: firefox 13:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:37 INFO - mozversion application_vendor: Mozilla 13:56:37 INFO - mozversion application_version: 52.0a1 13:56:37 INFO - mozversion platform_buildid: 20161011025846 13:56:37 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 13:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:37 INFO - mozversion platform_version: 52.0a1 13:56:37 INFO - using testdate: 1477515397 13:56:37 INFO - actual date: 1477515397 13:56:37 INFO - starting webserver on 'localhost:49277' 13:56:37 INFO - SUITE-START | Running 2 tests 13:56:37 INFO - TEST-START | dromaeo_css 13:56:37 INFO - operating with platform_type : mac_ 13:56:37 INFO - Initialising browser for dromaeo_css test... 13:56:37 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpmiMU5k/profile http://localhost:49277/getInfo.html) 13:56:39 INFO - PROCESS | 1655 | 2016-10-26 13:56:39.949 plugin-container[1657:7868] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b37, name = 'com.apple.tsm.portname' 13:56:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:39 INFO - PROCESS | 1655 | 2016-10-26 13:56:39.951 plugin-container[1657:7868] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a0b, name = 'com.apple.CFPasteboardClient' 13:56:39 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:39 INFO - PROCESS | 1655 | 2016-10-26 13:56:39.952 plugin-container[1657:7868] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:40 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 13:56:40 INFO - PROCESS | 1655 | colorDepth:24 13:56:40 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 13:56:40 INFO - PROCESS | 1655 | __metrics 13:56:40 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 13:56:40 INFO - TEST-INFO | 1655: exit 0 13:56:40 INFO - Browser initialized. 13:56:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:40 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpmiMU5k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:43 INFO - PROCESS | 1658 | 2016-10-26 13:56:43.134 plugin-container[1659:7991] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453b, name = 'com.apple.tsm.portname' 13:56:43 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:43 INFO - PROCESS | 1658 | 2016-10-26 13:56:43.134 plugin-container[1659:7991] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 13:56:43 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:56:43 INFO - PROCESS | 1658 | 2016-10-26 13:56:43.134 plugin-container[1659:7991] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:56:52 INFO - PROCESS | 1658 | RSS: Main: 238813184 13:56:52 INFO - PROCESS | 1658 | 13:57:42 INFO - PROCESS | 1658 | 1477515462426 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] 13:59:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 13:59:56 INFO - PROCESS | 1658 | RSS: Main: 253968384 13:59:56 INFO - PROCESS | 1658 | 14:02:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 14:02:59 INFO - PROCESS | 1658 | RSS: Main: 263626752 14:02:59 INFO - PROCESS | 1658 | 14:06:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 14:06:01 INFO - PROCESS | 1658 | RSS: Main: 268832768 14:06:01 INFO - PROCESS | 1658 | 14:09:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 14:09:04 INFO - PROCESS | 1658 | RSS: Main: 268750848 14:09:04 INFO - PROCESS | 1658 | 14:12:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 14:12:07 INFO - PROCESS | 1658 | RSS: Main: 274001920 14:12:07 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 14:15:10 INFO - PROCESS | 1658 | RSS: Main: 277176320 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | __start_tp_report 14:15:10 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:15:10 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:15:10 INFO - PROCESS | 1658 | |i|pagename|runs| 14:15:10 INFO - PROCESS | 1658 | |0;dojo.html;3265.1510607242108;3286.80279183249;3320.549202280197;3328.4508056170735;3331.983340083299;4874.78063487143;5247.632665713392;5376.8118115865955;5401.540869026133;5430.972845135779;5337.626366154371;5341.679499230049;5383.111786555213;5387.138057910735;5447.346318441782;4895.36360273164;4954.182559877616;4996.375453068366;5040.495950404948;5047.242913562958;4865.294532292815;5029.47190544993;5052.065367906931;5063.645544811865;5104.336436263299;3982.4424580558743;4449.488308844459;4731.95268047322;4955.776990035457;5005.524475174852;4941.332920055783;4960.900781984376;4980.551750342451;4981.078500477387;4991.276264941564;4905.239687848353;4968.6025117990475;4973.204287314049;4986.10250154972;5035.924461133086;5089.592832573422;5293.179557168645;5332.440093790135;5384;5398.811041613525;4715.976420117911;4985.700857948498;5924.703764811742;5930.851728706773;5931.110333449974;4276.850310239127;4954.20732682769;6011.248593925759;6041.456268935773;6043.214382130295;5394.217838413487;5441.075017247077;5453.645513041719;5498.3127109111365;5518.19986102013;6127.556056270658;6140.995089002538;6141.762184092961;6149.263577707967;6171.84570385735;5823.068309070529;5843.707814609253;5846.912296315559;5858.121281807763;5898.292204935349;5703.230063941398;5785.190073389729;5834.970825145847;6048.243969503812;6063.787767428119;4730.479647238801;5766.135079738073;5769;5780.508656764138;5854.2096816930025;4832.95167048325;5771.884562308815;5775.566832487496;5790.739416726257;5802.158686990447;4619.353290539327;4672.859814205579;4683.625309975194;4684.1568517666465;4714.033623107255;4170.457840480779;4221.071364299849;4249.596288352602;4278.636315913182;4304.053108316165;5447.645903016291;5527.972360138174;5549.778008879681;5569.331680198402;5593.3847276799515;5694.886102277931;5986.880262394728;5987.9101813472835;5996.700164991733;6003.939960600425;5422.186671999231;5471.288732464834;5486.561075113981;5541.445855414427;5638.577106717013;5133.589312854962;5196.038732834438;5198.818041368534;5208.114620514521;5208.765605547759;5088.923666145085;6273.592216505913;6290.654014029273;6301.464375528039;6303.4642055423965;5736.541076713769;5755.971220143872;5854.385289544707;5904.645721256738;5957.434043765836;5479.945200547943;5892.734826932712;6174.073888916699;6232.189815323979;6234.781782637586;5693.572982026448;5701.971490142523;5771.769129234784;5852.239208902815;5881.911771323348;4869.513048695102;5916.674582897982;6028;6039.667818270037;6052.576319657582;5808.273965754281;5831.650100993954;5839.211706419579;5840.883182336414;5848.766049357978;5599.468050535193;5633.549316054788;5801.361850196559;5805.622634528742;5819.447152520504;5478.835634930959;5644.012297847778;5671.092625179951;5674.375818660027;5711.286089238845;5781.046127388934;5803.622764520293;5814.244148260868;5818.389069147678;5835.649861008353;4515.322701594787;5060.51925067118;5564.02629539837;5643.153526970823;5652.604317697722 14:15:10 INFO - PROCESS | 1658 | |1;ext.html;455.83817744700633;479.1208133075806;496.53573908395646;514.3288009148063;522.5062316111276;36319.81840090802;40524.189516209655;40538;42091.57908420915;43765.12469750603;37679.4348084779;41362.37956430649;42757.57242427575;43055.78472107635;43336;8502.404831661801;9887.555060022316;9987.151092157139;9991.800163996715;9994.600215991351;9451.582262660588;9746.269029822755;9801.313908026441;9834.655787047455;9838.163756080707;8749.693760718375;9736.221102311834;9840.458774767385;9847.538115471132;9848.655297064604;9766.658166964158;9815;9816.460094694788;9822.116009559102;9862.90137098627;9906.801863962752;9962.900370996269;9969.551370188286;9980.151687106605;9996.50017499122;41355.7932210337;41585.1682966339;41704.79147604273;41785.1642967139;41791.7910410446;3314.486254630512;3368.2589830237307;3381.3406385754542;3526.2418580005424;3737.5514938207316;30658.84670576633;30954.841787247413;31074.533881991563;31197.064088077394;31867.84066079678;2887.768978481716;2980;3009.6990300969946;3031.7721322864277;3082.8747507159724;486068;488122.99999999645;489257;489574;490465;56983.71508142516;57208;57300.713496432254;57319.85360292771;57390;63666;64111;64374;64777;64954.67522662356;15633.530994070195;15796.447124350592;15827.920860395625;15935.282912268976;15964.600884977735;12147.635570932885;12501.749965000648;12595.433205505591;12607.991360691123;12622.747545049047;7659.4255430841795;7799.961000195076;7855.607219638995;7866.7639970800965;18107.81892181088;7662.233776622294;7831.138574756887;7854.253845884632;7901.446898717035;7920.960395198103;829.2453866981018;833.9408950632662;959.2278216036158;960.1023043454393;1016.5273147986222;24570.754292457204;29299.121026369245;29647.55528667072;30065.24836879052;31039.379212416075;995.5669283861544;1001.6844693921391;1025.1952217509368;1092.983605245922;1120.38938778366;13557.796633050511;15610.985285956376;15777;15854.524364269091;15883.841161588467;662295;664077;671986;672978;673371;58688;58955.70522147362;59312.40687593155;59897.80204395888;63776.68111659412;1334.8798608125314;1347.0772520823268;1355.600097971101;1356.9754835099634;1362.775142101542;29093.12720618385;30487;30796;31364.215894602818;31731.889383871454;51423.97152057013;52061;53001.93996120133;53093.20360194678;53643.46356536541;583451;586984;592792;593110;593412.0988185095;23753.524929500967;27627.03305384302;27823.582646259918;27933.16200513988;28020.43959120847;46215.76892115518;47273.52726472829;49078.75460622817;49094;49184;33871.49192762061;39427.80286098551;39731.006724832114;39998.40002400024;40342.1931561373;39452;39619;39776.2044759109;40322.47636383525;40780.98047548835;32948;37509.43735844019;38377.80811096038;38948;39291.21417571575;31973.36053278875;34787.65212347844;35758.8212058938;35840.28319433649;35869.28261434809;24153.51692966166;25849.353766155244;26021.6096758545;26357.472850543265;26651.600225996237 14:15:10 INFO - PROCESS | 1658 | |2;jquery.html;358.8726002269194;364.76290411232696;370.831271771344;376.8021788561007;389.17300735936135;19610.411687649375;20042.89978550109;20330.89834550829;20837.853918034503;20977.68533471999;9277.536123193848;9489.430634161938;17914.55213619657;20026.29907953222;20631.896840515816;4368.803403846819;4419.73481591104;4541.727496350213;5375.731213439332;5380.650257733254;3903.33643280643;5452.182172674111;5674.347450043257;5856.76572937082;7013.789586312393;6142.447179753821;6997.720091196346;7008.894866577006;7034.82412939678;7050.612216328125;6108.297545782225;6204.665996810662;6213.25440947087;6217.160683307741;6224.595401298924;5057.4689657585795;5327.174287985368;5360.2763626910255;6028.216331876872;6036.486898613623;12972.481100755958;13152.934235328763;13177.736445271137;15178.392864285415;24780.380490487703;1985.5631761012555;2201.3726088064823;2299.988500057506;2302.5049614332997;2519.0301733832425;9769.658061967868;9788.510574471247;9836.606535738561;10103.696889093266;10289.3311934724;1772.4416808705216;1865.3657756362766;1882;1883.1149359800872;2016.98991505043;94174;120751;125620.37189813993;128532;134838.65161348358;9392.812143757223;9395.389299695498;9544.188743956702;9982.251331150193;10125.189984801198;12306.630801075982;12401.379931003414;12450.81323780144;12451.875481245253;12462.75074498505;7971.561564113914;8101.392395570356;8123.837523249502;8144.75565733029;8197.549134797644;6280.403361680633;8107.878381824277;8302.799758064119;8589.312854971588;8612.138786121337;3823.866164684223;3827.8660246891227;3905.7851818150275;3956.742811717229;3964.5044369453817;1710.2389436700798;1772.2645102282665;1824.090057027556;1829.8170182981862;1878.2719897694153;880.4453194487432;883.7304622090325;937.1940131486916;941.4727752458645;1011.8735158105237;16821.663566728595;18156.364527241483;19719.40841774749;21194.364169074954;21267.574648506943;901.5942825728317;908.7591788176138;912.6349460215833;945.1682519382899;954.236610711428;10736.30214036085;11134.4202029888;11211.551537938554;11330.773384532264;11346.546138154546;570645;586242;591070;596069;596593;86741;89855;109456.71629851118;110155.44922275338;132117;748.3489364253026;789.9328557072713;910.0717268386209;910.139917777707;966.1160038564634;18157.45527634173;18545.072746362897;18599.81400185981;18817.529561761065;18845.96347200862;41816.95457613584;54963;55708.885822282515;56181.71909140428;56190.719046404505;80734.59632702034;80978.59510702408;81372.59313703394;82974.9256268574;83390.16609834066;7067.6819543119655;7230.3731660376;7257.600831954293;7400.296971787671;8012.399070069651;10832.458377080957;10847.837282440612;12832.486700531874;12906.935465322613;13094.934525327313;9101.681441149793;10277;10624.990625890528;10963.397013164353;11235.7752844941;10828.458577070958;10898.945505272422;10909.563617455213;10971.780564388828;11146.721331966766;11175.552977880794;11508.539658413905;11512.59705910289;11719.941400292944;11743.41282935867;7316.0489136411925;7318.963405183153;7441.255874412515;7511.06111736033;7603.619819009138;10944.835827462435;11188.944055279671;11217.383043932661;11490.195686301879;11596.710082248012 14:15:10 INFO - PROCESS | 1658 | |3;mootools.html;1460.2698650674658;1501.421952548269;1687.06367965779;1743.8316328060198;1780.3857669104154;7967.960160199191;8223.465474744153;8405.327573794097;8986.41588296761;9009.459432434058;8381.706640267592;8709.564521773918;8728.389012769092;8797.956010219956;8825.073367296438;2210.557888422314;2288.39357570244;2288.7596802335684;2289.1873384948353;2295.988520057397;2299.2297580310533;2317.316391664463;2346.671465994762;2347.5657003454417;2356.6229403295474;2288.496530763229;2317.2353123469215;2331.62693968965;2337.1118974789556;2347;2267.6145055340467;2267.8979445924892;2269.863808171515;2275.89758460868;2290.415943934286;2298.5058212484396;2306.688597039395;2311.5376924614975;2312.387217387394;2312.7687231276905;8837.248833849131;8854.911450885538;8884.511351875644;8904.462228264914;8912.598933047964;5192.4547922468355;5194.558462530689;5278.841634750964;5280.656757310762;5331.973340133313;3254.267789747312;3313.7017668409717;3439.7592168548213;3446.827658617059;3456.792592444436;993.2550587059706;999.7300728803256;1000.8098461292404;1012.71643939697;1024.068098030796;11205.439728013649;11209.887901120966;11437.828432573519;11577.94211028948;11620.418979051014;3706.4625629283605;4416.823327066945;4512.120136573337;4536.79584418702;4559.361689363492;8056.798580035546;9044.502552359552;9088.182063614306;9105.317101217302;9131.908680913106;5166.225066240094;5171.663841850268;5184.585233181337;5184.766685499161;5194.714290713971;4340.696151269444;4434.534373890695;4793.161196790547;4862.8784280392565;4875.1224779540025;3664.230511592542;3667.578228503703;3740.4202348636004;3762.1347090169415;3768.3593789055376;1132.8810474900017;1143.3425780176433;1148.2880614019361;1148.465963327057;1149.9137564682683;764.6903004283274;811.3752410643772;899.7885496908222;921.8202450522218;941.1717688434134;5663.688497132697;5707.686077265707;5887.381824908409;5938.732757025944;6056.697165141725;415.1365160466223;417.14485305124373;419.8698403494926;424.1495800919137;424.91501699660193;3766.981165094157;3786.9398360386285;3931.862384816575;3982.78094704794;4055;10387.84418233727;10632.096271816827;10734.677959661223;10766.246362754531;10767.78464430707;10617.681469555926;10714.51784669676;10728;10728.892711072946;10746.570137194425;7928.445008849325;8050.718224862102;8072.8385432291025;8112.148224436349;8174.814651875564;5744.655320680772;5762.6830524319885;5813.157092221689;5831.241938548132;5892.175095486549;9653.758656033655;9873.950630246803;9884.654037108667;9941.602335906482;9987.101160895554;9861.753456163653;10076.69769906904;10115.797684046425;10186.898131018595;10211.387316761018;6406.711697973509;6529.053287273414;6872.278410766798;6940.9652951734915;6971.372576468142;8214.219649133323;8274.420790544846;8395.370347224105;8404.285635721033;8424.368172386972;7357.963210183915;7411.851762964819;7502;7565;7619.771406857803;7217.67520461591;7310.780676579711;7322.96338518304;7439.665215065444;7462.328390444669;6830.180378354629;6857.451403887577;6880.311968803079;6906.965465172642;6921.1002569667635;4928.236123400879;4999.850004499871;5031.723255220998;5047.167217409086;5062.164742817541;4865.148598995091;4988.184039210079;5028.74856257193;5120.974395128001;5130.12787826078 14:15:10 INFO - PROCESS | 1658 | |4;prototype.html;289.3475213393798;301.4182627528869;307.445061663697;310.9082820567932;312.01714599013104;4729.385179926613;5079.517445842648;5409.188621706746;5450.582848459399;5459.481349271813;3967.7024223183234;5251.86870328242;5259.789608415659;5271.42014378418;5329.467053294668;3397.813120278384;4072.3891416287647;4122.50529936408;4130.318497447917;4131.467595206101;3938.468306778577;4104.794760261975;4125.535434920605;4134.359174327984;4141.7100802943805;3639.672429481346;3822.3310920588924;4074.22589707956;4083.3874918762126;4113.259613269625;3075.815451072943;3850.7280704384266;4044.413560033793;4089.693273004507;4111.09555897702;3574.160072382988;3591.9224232730076;3592.1738000259825;3593.9281214375565;3605.7475976681644;4193.937090943638;4991.078484485496;5179.948200517984;5213.426523082458;5229.607779416521;3870.9806450967844;4669.159551280768;4670.883227919295;4688.5545873142;4693.741844198567;4711.858644240679;5580.218769372291;5620.971895140539;5640.830775076754;5673.461021202979;3776.7686543090454;3837.9808100959594;3884.4173373994126;3930.410438434229;3955.6835453163676;4767.404074490689;4796.736179510125;4904.087405911698;5542.115680668592;5891.263592050994;3254.4304746669236;3984.960150398517;3991.4012898064943;3991.4212439196153;4024.3158663027357;3554.3779838528153;3611.5124458198334;4049.5747946465785;4065.5121385433936;4072.9592704073175;3694.113412780913;4365.9521714788225;4582.931256031162;4606.95393046072;4625.814967401267;5230.241614965808;5668.404817494186;5705.429457054344;5714.685692286964;5740;1104.861892263467;1195.940202989847;1263;1303.4069498378215;1332.906696531253;882.1090698394668;896.9058248883904;907.8229745199623;907.8592818113071;911.7902882337099;5264.763085661154;5323.813666521653;5330.615059437285;5336.439673834269;5340.813071542478;4906.730129842822;5023.6985780853265;5718.914216286759;5747.137929310553;5771.971140144273;4441.977790111029;4885.951140488621;5122.590192784568;5280.834857708322;5379.704116273564;2283.0068920019844;2501.349649091213;2586.4697736963876;2593.81843270973;2603.5183491054217;4531.546845315442;4728.645351598644;4728.668993170445;4798.448178459522;5120.8719782005;4519.7740112994215;4828.1031381171015;4946.653734238569;5001.899582091934;5029.396472423333;4279.700420970565;4360.732419142028;4491.101779644019;4896.35596777736;5084.898302034013;4079.816408261576;4201.7899105045235;4404.8107011106185;4726.2501186307545;4843.602416803705;3995.5005624296964;4040.616141466556;4577.954220457753;4725;4794.280857871207;5164.948350516597;5299.099153143898;6025.879482410415;6106.32830388648;6150.231221097363;3442.9483557747153;3671.9816400917825;3949.3878448840474;3952.584978577323;3957.683385329109;4502.617277531446;5154.819581314636;5877.970610146922;5927.911081333869;5956.404359564009;4922.630802689884;5662.943370566241;5669.719361881753;5675.744591493475;5694.963338860821;5672.241605102431;5692.544596432358;5700.548764031506;5739.139129130664;5755.280589926259;5285.867853303698;5536.7785288588;5579.0946337563055;5594.349666848371;5594.41258667834;5657.773689052392;5662;5690.662694266926;5711.659139054432;5734.541236701138;4736.8105275788585;5077.289179514797;5518.530924871431;5604.047311956896;5623.240862483676 14:15:10 INFO - PROCESS | 1658 | |5;yui.html;706.2584286499176;721.1166321256458;726.9345758881697;737.9372753315968;747.0624366420142;11409.771804563903;15008.47470338537;15107.942444028922;15132.24338783062;15162.39350425983;12229.327386993711;13987.860121398782;14849.257537123154;15044.473443429482;15099.094054356747;688.2463702246046;786.7325109462781;813.9418755617703;860.096898256831;862.4523427623442;676.5940435738543;690.2821066091259;828.6850996621306;865.6234537976001;866.0559989611322;872.6727477196051;890.0387581412059;890.6036813617943;891.2201823404521;897.0804924951943;877.7630039889258;889.621910687955;892.3976315986715;895.4224525181287;896.8744375787395;637.3403527349218;637.4995628431659;652.6377860287539;656.3469347998772;658.9703463344161;14727.55817325482;14843.406263749437;14866.628334291621;15034.774478382833;15048.849511504854;14077.64805879851;14097.64755881101;14113.364898579486;14136.151830890076;14287.285635718172;10411.219158563137;11670.708232294175;11765.176437649368;11855.525778968831;11975.461104250242;3725.4039353703547;3743.9064023399633;3774.981125094357;3808.295465338921;3843.3658446356317;111860;113570.86429135768;114134;114788;114977;10773.946130269298;10954.835677464844;10971.945140274247;11041.558337666564;11077.944610276896;22118.778812211993;22148.778512214994;22171.22400715967;22178.556428871656;22234.777652223594;6793.93206067933;7696.153423123452;7708.807279818049;7909.723159689498;7965.522068675898;4082.408050832613;4134.152498737752;4212.789360531961;4219.177260434247;4271.551487093872;3756.398976163801;4006.559278479365;4013.3578627419474;4036.6367026967714;4037.7375470594316;616.2327901762335;701.9684114214873;708;710.1442761472414;724.576122968059;558.7904535799075;579.458206576852;643.6878114114651;663.4261363920174;663.8937769956784;7920.643571039317;8758.47449153053;9265.675701350556;9407.247420206368;9502.47736374506;553.7037684838673;562.4207066721284;580.3789944759068;613.8693011068339;623.2859636000998;3589.9820500897326;3727.7390582658954;3808.771473711586;4311.9784401077795;4624.398828152319;142309;156413;157729.42270577376;157742;161518.1924090372;98404;110457;122501;127345.72654273339;141288;84611;106255.93744062615;108409.45795270974;108538.45730771453;109135;9402.764930876783;9901.653442129491;9908.25688073383;9925.950370248103;9957;63837.0424443643;64872.37819054561;65138;65907;66467.66766166138;78785.818212728;85557.57221213855;87798;95923;97161.0851674451;11478.426078696199;12028.15802893789;12735.29955852437;12742.745145097231;12924.353782311035;13530.661733456742;14286;14290.28548572588;14710.16122984627;14883.627909302355;11550.191486596193;12958.287294198533;13186.604401867959;13689.45242190341;14047.438102475786;11681.532738690357;13130.40913158891;13470.66323341885;13692.589222323346;13721.294259842613;12693.936530317289;13123.868761312264;13425;13517.256550889402;13781.767983235792;10930.344179349264;10937.289076210021;11030.22788404804;11144.275622084539;11223.60717374888;9371.062893710574;11134.053605443629;11139.772045590753;11236.94381528087;11327.660170194908 14:15:10 INFO - PROCESS | 1658 | __end_tp_report 14:15:10 INFO - PROCESS | 1658 | __start_cc_report 14:15:10 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,356 14:15:10 INFO - PROCESS | 1658 | __end_cc_report 14:15:10 INFO - PROCESS | 1658 | __startTimestamp1477516510509__endTimestamp 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:15:10 INFO - PROCESS | 1658 | Number of tests: 6 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5399.00 Median:5541.45 stddev:628.62 (11.3%) stddev-sans-first:607.85 14:15:10 INFO - PROCESS | 1658 | Values: 3265.2 3286.8 3320.5 3328.5 3332.0 4874.8 5247.6 5376.8 5401.5 5431.0 5337.6 5341.7 5383.1 5387.1 5447.3 4895.4 4954.2 4996.4 5040.5 5047.2 4865.3 5029.5 5052.1 5063.6 5104.3 3982.4 4449.5 4732.0 4955.8 5005.5 4941.3 4960.9 4980.6 4981.1 4991.3 4905.2 4968.6 4973.2 4986.1 5035.9 5089.6 5293.2 5332.4 5384.0 5398.8 4716.0 4985.7 5924.7 5930.9 5931.1 4276.9 4954.2 6011.2 6041.5 6043.2 5394.2 5441.1 5453.6 5498.3 5518.2 6127.6 6141.0 6141.8 6149.3 6171.8 5823.1 5843.7 5846.9 5858.1 5898.3 5703.2 5785.2 5835.0 6048.2 6063.8 4730.5 5766.1 5769.0 5780.5 5854.2 4833.0 5771.9 5775.6 5790.7 5802.2 4619.4 4672.9 4683.6 4684.2 4714.0 4170.5 4221.1 4249.6 4278.6 4304.1 5447.6 5528.0 5549.8 5569.3 5593.4 5694.9 5986.9 5987.9 5996.7 6003.9 5422.2 5471.3 5486.6 5541.4 5638.6 5133.6 5196.0 5198.8 5208.1 5208.8 5088.9 6273.6 6290.7 6301.5 6303.5 5736.5 5756.0 5854.4 5904.6 5957.4 5479.9 5892.7 6174.1 6232.2 6234.8 5693.6 5702.0 5771.8 5852.2 5881.9 4869.5 5916.7 6028.0 6039.7 6052.6 5808.3 5831.7 5839.2 5840.9 5848.8 5599.5 5633.5 5801.4 5805.6 5819.4 5478.8 5644.0 5671.1 5674.4 5711.3 5781.0 5803.6 5814.2 5818.4 5835.6 4515.3 5060.5 5564.0 5643.2 5652.6 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:71362.00 Median:41941.69 stddev:157096.64 (374.6%) stddev-sans-first:157447.14 14:15:10 INFO - PROCESS | 1658 | Values: 455.8 479.1 496.5 514.3 522.5 36319.8 40524.2 40538.0 42091.6 43765.1 37679.4 41362.4 42757.6 43055.8 43336.0 8502.4 9887.6 9987.2 9991.8 9994.6 9451.6 9746.3 9801.3 9834.7 9838.2 8749.7 9736.2 9840.5 9847.5 9848.7 9766.7 9815.0 9816.5 9822.1 9862.9 9906.8 9962.9 9969.6 9980.2 9996.5 41355.8 41585.2 41704.8 41785.2 41791.8 3314.5 3368.3 3381.3 3526.2 3737.6 30658.8 30954.8 31074.5 31197.1 31867.8 2887.8 2980.0 3009.7 3031.8 3082.9 486068.0 488123.0 489257.0 489574.0 490465.0 56983.7 57208.0 57300.7 57319.9 57390.0 63666.0 64111.0 64374.0 64777.0 64954.7 15633.5 15796.4 15827.9 15935.3 15964.6 12147.6 12501.7 12595.4 12608.0 12622.7 7659.4 7800.0 7855.6 7866.8 18107.8 7662.2 7831.1 7854.3 7901.4 7921.0 829.2 833.9 959.2 960.1 1016.5 24570.8 29299.1 29647.6 30065.2 31039.4 995.6 1001.7 1025.2 1093.0 1120.4 13557.8 15611.0 15777.0 15854.5 15883.8 662295.0 664077.0 671986.0 672978.0 673371.0 58688.0 58955.7 59312.4 59897.8 63776.7 1334.9 1347.1 1355.6 1357.0 1362.8 29093.1 30487.0 30796.0 31364.2 31731.9 51424.0 52061.0 53001.9 53093.2 53643.5 583451.0 586984.0 592792.0 593110.0 593412.1 23753.5 27627.0 27823.6 27933.2 28020.4 46215.8 47273.5 49078.8 49094.0 49184.0 33871.5 39427.8 39731.0 39998.4 40342.2 39452.0 39619.0 39776.2 40322.5 40781.0 32948.0 37509.4 38377.8 38948.0 39291.2 31973.4 34787.7 35758.8 35840.3 35869.3 24153.5 25849.4 26021.6 26357.5 26651.6 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33653.36 Median:3904.56 stddev:98053.96 (2511.3%) stddev-sans-first:98297.15 14:15:10 INFO - PROCESS | 1658 | Values: 358.9 364.8 370.8 376.8 389.2 19610.4 20042.9 20330.9 20837.9 20977.7 9277.5 9489.4 17914.6 20026.3 20631.9 4368.8 4419.7 4541.7 5375.7 5380.7 3903.3 5452.2 5674.3 5856.8 7013.8 6142.4 6997.7 7008.9 7034.8 7050.6 6108.3 6204.7 6213.3 6217.2 6224.6 5057.5 5327.2 5360.3 6028.2 6036.5 12972.5 13152.9 13177.7 15178.4 24780.4 1985.6 2201.4 2300.0 2302.5 2519.0 9769.7 9788.5 9836.6 10103.7 10289.3 1772.4 1865.4 1882.0 1883.1 2017.0 94174.0 120751.0 125620.4 128532.0 134838.7 9392.8 9395.4 9544.2 9982.3 10125.2 12306.6 12401.4 12450.8 12451.9 12462.8 7971.6 8101.4 8123.8 8144.8 8197.5 6280.4 8107.9 8302.8 8589.3 8612.1 3823.9 3827.9 3905.8 3956.7 3964.5 1710.2 1772.3 1824.1 1829.8 1878.3 880.4 883.7 937.2 941.5 1011.9 16821.7 18156.4 19719.4 21194.4 21267.6 901.6 908.8 912.6 945.2 954.2 10736.3 11134.4 11211.6 11330.8 11346.5 570645.0 586242.0 591070.0 596069.0 596593.0 86741.0 89855.0 109456.7 110155.4 132117.0 748.3 789.9 910.1 910.1 966.1 18157.5 18545.1 18599.8 18817.5 18846.0 41817.0 54963.0 55708.9 56181.7 56190.7 80734.6 80978.6 81372.6 82974.9 83390.2 7067.7 7230.4 7257.6 7400.3 8012.4 10832.5 10847.8 12832.5 12906.9 13094.9 9101.7 10277.0 10625.0 10963.4 11235.8 10828.5 10898.9 10909.6 10971.8 11146.7 11175.6 11508.5 11512.6 11719.9 11743.4 7316.0 7319.0 7441.3 7511.1 7603.6 10944.8 11188.9 11217.4 11490.2 11596.7 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5592.23 Median:5014.30 stddev:3182.04 (63.5%) stddev-sans-first:3175.82 14:15:10 INFO - PROCESS | 1658 | Values: 1460.3 1501.4 1687.1 1743.8 1780.4 7968.0 8223.5 8405.3 8986.4 9009.5 8381.7 8709.6 8728.4 8798.0 8825.1 2210.6 2288.4 2288.8 2289.2 2296.0 2299.2 2317.3 2346.7 2347.6 2356.6 2288.5 2317.2 2331.6 2337.1 2347.0 2267.6 2267.9 2269.9 2275.9 2290.4 2298.5 2306.7 2311.5 2312.4 2312.8 8837.2 8854.9 8884.5 8904.5 8912.6 5192.5 5194.6 5278.8 5280.7 5332.0 3254.3 3313.7 3439.8 3446.8 3456.8 993.3 999.7 1000.8 1012.7 1024.1 11205.4 11209.9 11437.8 11577.9 11620.4 3706.5 4416.8 4512.1 4536.8 4559.4 8056.8 9044.5 9088.2 9105.3 9131.9 5166.2 5171.7 5184.6 5184.8 5194.7 4340.7 4434.5 4793.2 4862.9 4875.1 3664.2 3667.6 3740.4 3762.1 3768.4 1132.9 1143.3 1148.3 1148.5 1149.9 764.7 811.4 899.8 921.8 941.2 5663.7 5707.7 5887.4 5938.7 6056.7 415.1 417.1 419.9 424.1 424.9 3767.0 3786.9 3931.9 3982.8 4055.0 10387.8 10632.1 10734.7 10766.2 10767.8 10617.7 10714.5 10728.0 10728.9 10746.6 7928.4 8050.7 8072.8 8112.1 8174.8 5744.7 5762.7 5813.2 5831.2 5892.2 9653.8 9874.0 9884.7 9941.6 9987.1 9861.8 10076.7 10115.8 10186.9 10211.4 6406.7 6529.1 6872.3 6941.0 6971.4 8214.2 8274.4 8395.4 8404.3 8424.4 7358.0 7411.9 7502.0 7565.0 7619.8 7217.7 7310.8 7323.0 7439.7 7462.3 6830.2 6857.5 6880.3 6907.0 6921.1 4928.2 4999.9 5031.7 5047.2 5062.2 4865.1 4988.2 5028.7 5121.0 5130.1 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4389.79 Median:4733.10 stddev:1349.83 (28.5%) stddev-sans-first:1318.07 14:15:10 INFO - PROCESS | 1658 | Values: 289.3 301.4 307.4 310.9 312.0 4729.4 5079.5 5409.2 5450.6 5459.5 3967.7 5251.9 5259.8 5271.4 5329.5 3397.8 4072.4 4122.5 4130.3 4131.5 3938.5 4104.8 4125.5 4134.4 4141.7 3639.7 3822.3 4074.2 4083.4 4113.3 3075.8 3850.7 4044.4 4089.7 4111.1 3574.2 3591.9 3592.2 3593.9 3605.7 4193.9 4991.1 5179.9 5213.4 5229.6 3871.0 4669.2 4670.9 4688.6 4693.7 4711.9 5580.2 5621.0 5640.8 5673.5 3776.8 3838.0 3884.4 3930.4 3955.7 4767.4 4796.7 4904.1 5542.1 5891.3 3254.4 3985.0 3991.4 3991.4 4024.3 3554.4 3611.5 4049.6 4065.5 4073.0 3694.1 4366.0 4582.9 4607.0 4625.8 5230.2 5668.4 5705.4 5714.7 5740.0 1104.9 1195.9 1263.0 1303.4 1332.9 882.1 896.9 907.8 907.9 911.8 5264.8 5323.8 5330.6 5336.4 5340.8 4906.7 5023.7 5718.9 5747.1 5772.0 4442.0 4886.0 5122.6 5280.8 5379.7 2283.0 2501.3 2586.5 2593.8 2603.5 4531.5 4728.6 4728.7 4798.4 5120.9 4519.8 4828.1 4946.7 5001.9 5029.4 4279.7 4360.7 4491.1 4896.4 5084.9 4079.8 4201.8 4404.8 4726.3 4843.6 3995.5 4040.6 4578.0 4725.0 4794.3 5164.9 5299.1 6025.9 6106.3 6150.2 3442.9 3672.0 3949.4 3952.6 3957.7 4502.6 5154.8 5878.0 5927.9 5956.4 4922.6 5662.9 5669.7 5675.7 5695.0 5672.2 5692.5 5700.5 5739.1 5755.3 5285.9 5536.8 5579.1 5594.3 5594.4 5657.8 5662.0 5690.7 5711.7 5734.5 4736.8 5077.3 5518.5 5604.0 5623.2 14:15:10 INFO - PROCESS | 1658 | 14:15:10 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24615.43 Median:3750.15 stddev:39514.81 (1053.7%) stddev-sans-first:39584.88 14:15:10 INFO - PROCESS | 1658 | Values: 706.3 721.1 726.9 737.9 747.1 11409.8 15008.5 15107.9 15132.2 15162.4 12229.3 13987.9 14849.3 15044.5 15099.1 688.2 786.7 813.9 860.1 862.5 676.6 690.3 828.7 865.6 866.1 872.7 890.0 890.6 891.2 897.1 877.8 889.6 892.4 895.4 896.9 637.3 637.5 652.6 656.3 659.0 14727.6 14843.4 14866.6 15034.8 15048.8 14077.6 14097.6 14113.4 14136.2 14287.3 10411.2 11670.7 11765.2 11855.5 11975.5 3725.4 3743.9 3775.0 3808.3 3843.4 111860.0 113570.9 114134.0 114788.0 114977.0 10773.9 10954.8 10971.9 11041.6 11077.9 22118.8 22148.8 22171.2 22178.6 22234.8 6793.9 7696.2 7708.8 7909.7 7965.5 4082.4 4134.2 4212.8 4219.2 4271.6 3756.4 4006.6 4013.4 4036.6 4037.7 616.2 702.0 708.0 710.1 724.6 558.8 579.5 643.7 663.4 663.9 7920.6 8758.5 9265.7 9407.2 9502.5 553.7 562.4 580.4 613.9 623.3 3590.0 3727.7 3808.8 4312.0 4624.4 142309.0 156413.0 157729.4 157742.0 161518.2 98404.0 110457.0 122501.0 127345.7 141288.0 84611.0 106255.9 108409.5 108538.5 109135.0 9402.8 9901.7 9908.3 9926.0 9957.0 63837.0 64872.4 65138.0 65907.0 66467.7 78785.8 85557.6 87798.0 95923.0 97161.1 11478.4 12028.2 12735.3 12742.7 12924.4 13530.7 14286.0 14290.3 14710.2 14883.6 11550.2 12958.3 13186.6 13689.5 14047.4 11681.5 13130.4 13470.7 13692.6 13721.3 12693.9 13123.9 13425.0 13517.3 13781.8 10930.3 10937.3 11030.2 11144.3 11223.6 9371.1 11134.1 11139.8 11236.9 11327.7 14:15:10 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:15:10 INFO - PROCESS | 1658 | 14:15:11 INFO - TEST-INFO | 1658: exit 0 14:15:11 INFO - TEST-OK | dromaeo_css | took 1113783ms 14:15:11 INFO - TEST-START | kraken 14:15:11 INFO - operating with platform_type : mac_ 14:15:11 INFO - Initialising browser for kraken test... 14:15:11 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmprz2Z9e/profile http://localhost:49277/getInfo.html) 14:15:13 INFO - PROCESS | 1667 | 2016-10-26 14:15:13.723 plugin-container[1668:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 14:15:13 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:13 INFO - PROCESS | 1667 | 2016-10-26 14:15:13.726 plugin-container[1668:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 14:15:13 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:13 INFO - PROCESS | 1667 | 2016-10-26 14:15:13.726 plugin-container[1668:10140] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:13 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 14:15:13 INFO - PROCESS | 1667 | colorDepth:24 14:15:13 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 14:15:13 INFO - PROCESS | 1667 | __metrics 14:15:13 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:15:14 INFO - TEST-INFO | 1667: exit 0 14:15:14 INFO - Browser initialized. 14:15:14 INFO - Running cycle 1/1 for kraken test... 14:15:14 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmprz2Z9e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:16 INFO - PROCESS | 1669 | 2016-10-26 14:15:16.862 plugin-container[1670:10262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 14:15:16 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:16 INFO - PROCESS | 1669 | 2016-10-26 14:15:16.862 plugin-container[1670:10262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 14:15:16 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:15:16 INFO - PROCESS | 1669 | 2016-10-26 14:15:16.862 plugin-container[1670:10262] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:15:26 INFO - PROCESS | 1669 | RSS: Main: 238878720 14:15:26 INFO - PROCESS | 1669 | 14:15:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:30 INFO - PROCESS | 1669 | RSS: Main: 252256256 14:15:30 INFO - PROCESS | 1669 | 14:15:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 14:15:33 INFO - PROCESS | 1669 | RSS: Main: 259858432 14:15:33 INFO - PROCESS | 1669 | 14:15:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 14:15:37 INFO - PROCESS | 1669 | RSS: Main: 260804608 14:15:37 INFO - PROCESS | 1669 | 14:15:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 14:15:40 INFO - PROCESS | 1669 | RSS: Main: 262885376 14:15:40 INFO - PROCESS | 1669 | 14:15:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:43 INFO - PROCESS | 1669 | RSS: Main: 263507968 14:15:43 INFO - PROCESS | 1669 | 14:15:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:46 INFO - PROCESS | 1669 | RSS: Main: 263618560 14:15:46 INFO - PROCESS | 1669 | 14:15:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:50 INFO - PROCESS | 1669 | RSS: Main: 263843840 14:15:50 INFO - PROCESS | 1669 | 14:15:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 14:15:54 INFO - PROCESS | 1669 | RSS: Main: 263880704 14:15:54 INFO - PROCESS | 1669 | 14:15:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:56 INFO - PROCESS | 1669 | RSS: Main: 263741440 14:15:56 INFO - PROCESS | 1669 | 14:15:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:58 INFO - PROCESS | 1669 | RSS: Main: 263774208 14:15:58 INFO - PROCESS | 1669 | 14:16:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:01 INFO - PROCESS | 1669 | RSS: Main: 263843840 14:16:01 INFO - PROCESS | 1669 | 14:16:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:05 INFO - PROCESS | 1669 | RSS: Main: 264343552 14:16:05 INFO - PROCESS | 1669 | 14:16:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:08 INFO - PROCESS | 1669 | RSS: Main: 264032256 14:16:08 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 14:16:10 INFO - PROCESS | 1669 | RSS: Main: 265437184 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | __start_tp_report 14:16:10 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 14:16:10 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 14:16:10 INFO - PROCESS | 1669 | |i|pagename|runs| 14:16:10 INFO - PROCESS | 1669 | |0;ai-astar;114;117;118;118;118;118;118;116;97;173 14:16:10 INFO - PROCESS | 1669 | |1;audio-beat-detection;177;125;117;152;112;115;123;119;143;114 14:16:10 INFO - PROCESS | 1669 | |2;audio-dft;198;261;230;276;238;199;198;198;192;200 14:16:10 INFO - PROCESS | 1669 | |3;audio-fft;104;60;59;84;62;61;61;59;83;75 14:16:10 INFO - PROCESS | 1669 | |4;audio-oscillator;85;72;90;105;98;104;97;70;73;89 14:16:10 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;92;92;90;114;90;86;92;89;91;130 14:16:10 INFO - PROCESS | 1669 | |6;imaging-darkroom;130;170;127;103;101;101;113;110;100;100 14:16:10 INFO - PROCESS | 1669 | |7;imaging-desaturate;84;100;78;84;150;102;84;142;146;91 14:16:10 INFO - PROCESS | 1669 | |8;json-parse-financial;58;55;57;55;56;56;57;56;57;58 14:16:10 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;69;68;83;78;96;97;71;69;67;90 14:16:10 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;89;87;91;88;92;91;81;96;109;110 14:16:10 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;182;146;161;161;146;151;149;151;196;175 14:16:10 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;178;178;175;176;177;177;176;176;162;236 14:16:10 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;71;71;73;71;71;71;67;61;85;89 14:16:10 INFO - PROCESS | 1669 | __end_tp_report 14:16:10 INFO - PROCESS | 1669 | __start_cc_report 14:16:10 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,928 14:16:10 INFO - PROCESS | 1669 | __end_cc_report 14:16:10 INFO - PROCESS | 1669 | __startTimestamp1477516570962__endTimestamp 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | ------- Summary: start ------- 14:16:10 INFO - PROCESS | 1669 | Number of tests: 14 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:120.70 Median:118.00 stddev:19.48 (16.5%) stddev-sans-first:20.51 14:16:10 INFO - PROCESS | 1669 | Values: 114.0 117.0 118.0 118.0 118.0 118.0 118.0 116.0 97.0 173.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:124.00 stddev:21.16 (17.1%) stddev-sans-first:13.89 14:16:10 INFO - PROCESS | 1669 | Values: 177.0 125.0 117.0 152.0 112.0 115.0 123.0 119.0 143.0 114.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:219.00 Median:215.00 stddev:30.38 (14.1%) stddev-sans-first:31.26 14:16:10 INFO - PROCESS | 1669 | Values: 198.0 261.0 230.0 276.0 238.0 199.0 198.0 198.0 192.0 200.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:70.80 Median:61.50 stddev:15.30 (24.9%) stddev-sans-first:10.51 14:16:10 INFO - PROCESS | 1669 | Values: 104.0 60.0 59.0 84.0 62.0 61.0 61.0 59.0 83.0 75.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:87.00 stddev:13.10 (15.1%) stddev-sans-first:13.84 14:16:10 INFO - PROCESS | 1669 | Values: 85.0 72.0 90.0 105.0 98.0 104.0 97.0 70.0 73.0 89.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:90.50 stddev:14.03 (15.5%) stddev-sans-first:14.78 14:16:10 INFO - PROCESS | 1669 | Values: 92.0 92.0 90.0 114.0 90.0 86.0 92.0 89.0 91.0 130.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:111.50 stddev:22.13 (19.8%) stddev-sans-first:22.84 14:16:10 INFO - PROCESS | 1669 | Values: 130.0 170.0 127.0 103.0 101.0 101.0 113.0 110.0 100.0 100.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:106.10 Median:81.00 stddev:28.57 (35.3%) stddev-sans-first:29.16 14:16:10 INFO - PROCESS | 1669 | Values: 84.0 100.0 78.0 84.0 150.0 102.0 84.0 142.0 146.0 91.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.08 (1.9%) stddev-sans-first:1.00 14:16:10 INFO - PROCESS | 1669 | Values: 58.0 55.0 57.0 55.0 56.0 56.0 57.0 56.0 57.0 58.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:80.50 stddev:11.92 (14.8%) stddev-sans-first:12.11 14:16:10 INFO - PROCESS | 1669 | Values: 69.0 68.0 83.0 78.0 96.0 97.0 71.0 69.0 67.0 90.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:90.00 stddev:9.32 (10.4%) stddev-sans-first:9.75 14:16:10 INFO - PROCESS | 1669 | Values: 89.0 87.0 91.0 88.0 92.0 91.0 81.0 96.0 109.0 110.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:161.00 stddev:17.16 (10.7%) stddev-sans-first:16.57 14:16:10 INFO - PROCESS | 1669 | Values: 182.0 146.0 161.0 161.0 146.0 151.0 149.0 151.0 196.0 175.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:177.00 stddev:19.85 (11.2%) stddev-sans-first:21.02 14:16:10 INFO - PROCESS | 1669 | Values: 178.0 178.0 175.0 176.0 177.0 177.0 176.0 176.0 162.0 236.0 14:16:10 INFO - PROCESS | 1669 | 14:16:10 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:71.00 stddev:8.16 (11.5%) stddev-sans-first:8.63 14:16:10 INFO - PROCESS | 1669 | Values: 71.0 71.0 73.0 71.0 71.0 71.0 67.0 61.0 85.0 89.0 14:16:10 INFO - PROCESS | 1669 | -------- Summary: end -------- 14:16:10 INFO - PROCESS | 1669 | 14:16:11 INFO - TEST-INFO | 1669: exit 0 14:16:11 INFO - TEST-OK | kraken | took 60725ms 14:16:11 INFO - SUITE-END | took 1174s 14:16:12 INFO - Completed test suite (00:19:34) 14:16:12 INFO - javascript benchmark 14:16:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7098.504119410164, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.1510607242108, 3286.80279183249, 3320.549202280197, 3328.4508056170735, 3331.983340083299, 4874.78063487143, 5247.632665713392, 5376.8118115865955, 5401.540869026133, 5430.972845135779, 5337.626366154371, 5341.679499230049, 5383.111786555213, 5387.138057910735, 5447.346318441782, 4895.36360273164, 4954.182559877616, 4996.375453068366, 5040.495950404948, 5047.242913562958, 4865.294532292815, 5029.47190544993, 5052.065367906931, 5063.645544811865, 5104.336436263299, 3982.4424580558743, 4449.488308844459, 4731.95268047322, 4955.776990035457, 5005.524475174852, 4941.332920055783, 4960.900781984376, 4980.551750342451, 4981.078500477387, 4991.276264941564, 4905.239687848353, 4968.6025117990475, 4973.204287314049, 4986.10250154972, 5035.924461133086, 5089.592832573422, 5293.179557168645, 5332.440093790135, 5384.0, 5398.811041613525, 4715.976420117911, 4985.700857948498, 5924.703764811742, 5930.851728706773, 5931.110333449974, 4276.850310239127, 4954.20732682769, 6011.248593925759, 6041.456268935773, 6043.214382130295, 5394.217838413487, 5441.075017247077, 5453.645513041719, 5498.3127109111365, 5518.19986102013, 6127.556056270658, 6140.995089002538, 6141.762184092961, 6149.263577707967, 6171.84570385735, 5823.068309070529, 5843.707814609253, 5846.912296315559, 5858.121281807763, 5898.292204935349, 5703.230063941398, 5785.190073389729, 5834.970825145847, 6048.243969503812, 6063.787767428119, 4730.479647238801, 5766.135079738073, 5769.0, 5780.508656764138, 5854.2096816930025, 4832.95167048325, 5771.884562308815, 5775.566832487496, 5790.739416726257, 5802.158686990447, 4619.353290539327, 4672.859814205579, 4683.625309975194, 4684.1568517666465, 4714.033623107255, 4170.457840480779, 4221.071364299849, 4249.596288352602, 4278.636315913182, 4304.053108316165, 5447.645903016291, 5527.972360138174, 5549.778008879681, 5569.331680198402, 5593.3847276799515, 5694.886102277931, 5986.880262394728, 5987.9101813472835, 5996.700164991733, 6003.939960600425, 5422.186671999231, 5471.288732464834, 5486.561075113981, 5541.445855414427, 5638.577106717013, 5133.589312854962, 5196.038732834438, 5198.818041368534, 5208.114620514521, 5208.765605547759, 5088.923666145085, 6273.592216505913, 6290.654014029273, 6301.464375528039, 6303.4642055423965, 5736.541076713769, 5755.971220143872, 5854.385289544707, 5904.645721256738, 5957.434043765836, 5479.945200547943, 5892.734826932712, 6174.073888916699, 6232.189815323979, 6234.781782637586, 5693.572982026448, 5701.971490142523, 5771.769129234784, 5852.239208902815, 5881.911771323348, 4869.513048695102, 5916.674582897982, 6028.0, 6039.667818270037, 6052.576319657582, 5808.273965754281, 5831.650100993954, 5839.211706419579, 5840.883182336414, 5848.766049357978, 5599.468050535193, 5633.549316054788, 5801.361850196559, 5805.622634528742, 5819.447152520504, 5478.835634930959, 5644.012297847778, 5671.092625179951, 5674.375818660027, 5711.286089238845, 5781.046127388934, 5803.622764520293, 5814.244148260868, 5818.389069147678, 5835.649861008353, 4515.322701594787, 5060.51925067118, 5564.02629539837, 5643.153526970823, 5652.604317697722], "value": 5363.748670944866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.83817744700633, 479.1208133075806, 496.53573908395646, 514.3288009148063, 522.5062316111276, 36319.81840090802, 40524.189516209655, 40538.0, 42091.57908420915, 43765.12469750603, 37679.4348084779, 41362.37956430649, 42757.57242427575, 43055.78472107635, 43336.0, 8502.404831661801, 9887.555060022316, 9987.151092157139, 9991.800163996715, 9994.600215991351, 9451.582262660588, 9746.269029822755, 9801.313908026441, 9834.655787047455, 9838.163756080707, 8749.693760718375, 9736.221102311834, 9840.458774767385, 9847.538115471132, 9848.655297064604, 9766.658166964158, 9815.0, 9816.460094694788, 9822.116009559102, 9862.90137098627, 9906.801863962752, 9962.900370996269, 9969.551370188286, 9980.151687106605, 9996.50017499122, 41355.7932210337, 41585.1682966339, 41704.79147604273, 41785.1642967139, 41791.7910410446, 3314.486254630512, 3368.2589830237307, 3381.3406385754542, 3526.2418580005424, 3737.5514938207316, 30658.84670576633, 30954.841787247413, 31074.533881991563, 31197.064088077394, 31867.84066079678, 2887.768978481716, 2980.0, 3009.6990300969946, 3031.7721322864277, 3082.8747507159724, 486068.0, 488122.99999999645, 489257.0, 489574.0, 490465.0, 56983.71508142516, 57208.0, 57300.713496432254, 57319.85360292771, 57390.0, 63666.0, 64111.0, 64374.0, 64777.0, 64954.67522662356, 15633.530994070195, 15796.447124350592, 15827.920860395625, 15935.282912268976, 15964.600884977735, 12147.635570932885, 12501.749965000648, 12595.433205505591, 12607.991360691123, 12622.747545049047, 7659.4255430841795, 7799.961000195076, 7855.607219638995, 7866.7639970800965, 18107.81892181088, 7662.233776622294, 7831.138574756887, 7854.253845884632, 7901.446898717035, 7920.960395198103, 829.2453866981018, 833.9408950632662, 959.2278216036158, 960.1023043454393, 1016.5273147986222, 24570.754292457204, 29299.121026369245, 29647.55528667072, 30065.24836879052, 31039.379212416075, 995.5669283861544, 1001.6844693921391, 1025.1952217509368, 1092.983605245922, 1120.38938778366, 13557.796633050511, 15610.985285956376, 15777.0, 15854.524364269091, 15883.841161588467, 662295.0, 664077.0, 671986.0, 672978.0, 673371.0, 58688.0, 58955.70522147362, 59312.40687593155, 59897.80204395888, 63776.68111659412, 1334.8798608125314, 1347.0772520823268, 1355.600097971101, 1356.9754835099634, 1362.775142101542, 29093.12720618385, 30487.0, 30796.0, 31364.215894602818, 31731.889383871454, 51423.97152057013, 52061.0, 53001.93996120133, 53093.20360194678, 53643.46356536541, 583451.0, 586984.0, 592792.0, 593110.0, 593412.0988185095, 23753.524929500967, 27627.03305384302, 27823.582646259918, 27933.16200513988, 28020.43959120847, 46215.76892115518, 47273.52726472829, 49078.75460622817, 49094.0, 49184.0, 33871.49192762061, 39427.80286098551, 39731.006724832114, 39998.40002400024, 40342.1931561373, 39452.0, 39619.0, 39776.2044759109, 40322.47636383525, 40780.98047548835, 32948.0, 37509.43735844019, 38377.80811096038, 38948.0, 39291.21417571575, 31973.36053278875, 34787.65212347844, 35758.8212058938, 35840.28319433649, 35869.28261434809, 24153.51692966166, 25849.353766155244, 26021.6096758545, 26357.472850543265, 26651.600225996237], "value": 19719.38624257037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8726002269194, 364.76290411232696, 370.831271771344, 376.8021788561007, 389.17300735936135, 19610.411687649375, 20042.89978550109, 20330.89834550829, 20837.853918034503, 20977.68533471999, 9277.536123193848, 9489.430634161938, 17914.55213619657, 20026.29907953222, 20631.896840515816, 4368.803403846819, 4419.73481591104, 4541.727496350213, 5375.731213439332, 5380.650257733254, 3903.33643280643, 5452.182172674111, 5674.347450043257, 5856.76572937082, 7013.789586312393, 6142.447179753821, 6997.720091196346, 7008.894866577006, 7034.82412939678, 7050.612216328125, 6108.297545782225, 6204.665996810662, 6213.25440947087, 6217.160683307741, 6224.595401298924, 5057.4689657585795, 5327.174287985368, 5360.2763626910255, 6028.216331876872, 6036.486898613623, 12972.481100755958, 13152.934235328763, 13177.736445271137, 15178.392864285415, 24780.380490487703, 1985.5631761012555, 2201.3726088064823, 2299.988500057506, 2302.5049614332997, 2519.0301733832425, 9769.658061967868, 9788.510574471247, 9836.606535738561, 10103.696889093266, 10289.3311934724, 1772.4416808705216, 1865.3657756362766, 1882.0, 1883.1149359800872, 2016.98991505043, 94174.0, 120751.0, 125620.37189813993, 128532.0, 134838.65161348358, 9392.812143757223, 9395.389299695498, 9544.188743956702, 9982.251331150193, 10125.189984801198, 12306.630801075982, 12401.379931003414, 12450.81323780144, 12451.875481245253, 12462.75074498505, 7971.561564113914, 8101.392395570356, 8123.837523249502, 8144.75565733029, 8197.549134797644, 6280.403361680633, 8107.878381824277, 8302.799758064119, 8589.312854971588, 8612.138786121337, 3823.866164684223, 3827.8660246891227, 3905.7851818150275, 3956.742811717229, 3964.5044369453817, 1710.2389436700798, 1772.2645102282665, 1824.090057027556, 1829.8170182981862, 1878.2719897694153, 880.4453194487432, 883.7304622090325, 937.1940131486916, 941.4727752458645, 1011.8735158105237, 16821.663566728595, 18156.364527241483, 19719.40841774749, 21194.364169074954, 21267.574648506943, 901.5942825728317, 908.7591788176138, 912.6349460215833, 945.1682519382899, 954.236610711428, 10736.30214036085, 11134.4202029888, 11211.551537938554, 11330.773384532264, 11346.546138154546, 570645.0, 586242.0, 591070.0, 596069.0, 596593.0, 86741.0, 89855.0, 109456.71629851118, 110155.44922275338, 132117.0, 748.3489364253026, 789.9328557072713, 910.0717268386209, 910.139917777707, 966.1160038564634, 18157.45527634173, 18545.072746362897, 18599.81400185981, 18817.529561761065, 18845.96347200862, 41816.95457613584, 54963.0, 55708.885822282515, 56181.71909140428, 56190.719046404505, 80734.59632702034, 80978.59510702408, 81372.59313703394, 82974.9256268574, 83390.16609834066, 7067.6819543119655, 7230.3731660376, 7257.600831954293, 7400.296971787671, 8012.399070069651, 10832.458377080957, 10847.837282440612, 12832.486700531874, 12906.935465322613, 13094.934525327313, 9101.681441149793, 10277.0, 10624.990625890528, 10963.397013164353, 11235.7752844941, 10828.458577070958, 10898.945505272422, 10909.563617455213, 10971.780564388828, 11146.721331966766, 11175.552977880794, 11508.539658413905, 11512.59705910289, 11719.941400292944, 11743.41282935867, 7316.0489136411925, 7318.963405183153, 7441.255874412515, 7511.06111736033, 7603.619819009138, 10944.835827462435, 11188.944055279671, 11217.383043932661, 11490.195686301879, 11596.710082248012], "value": 9041.49563719248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.2698650674658, 1501.421952548269, 1687.06367965779, 1743.8316328060198, 1780.3857669104154, 7967.960160199191, 8223.465474744153, 8405.327573794097, 8986.41588296761, 9009.459432434058, 8381.706640267592, 8709.564521773918, 8728.389012769092, 8797.956010219956, 8825.073367296438, 2210.557888422314, 2288.39357570244, 2288.7596802335684, 2289.1873384948353, 2295.988520057397, 2299.2297580310533, 2317.316391664463, 2346.671465994762, 2347.5657003454417, 2356.6229403295474, 2288.496530763229, 2317.2353123469215, 2331.62693968965, 2337.1118974789556, 2347.0, 2267.6145055340467, 2267.8979445924892, 2269.863808171515, 2275.89758460868, 2290.415943934286, 2298.5058212484396, 2306.688597039395, 2311.5376924614975, 2312.387217387394, 2312.7687231276905, 8837.248833849131, 8854.911450885538, 8884.511351875644, 8904.462228264914, 8912.598933047964, 5192.4547922468355, 5194.558462530689, 5278.841634750964, 5280.656757310762, 5331.973340133313, 3254.267789747312, 3313.7017668409717, 3439.7592168548213, 3446.827658617059, 3456.792592444436, 993.2550587059706, 999.7300728803256, 1000.8098461292404, 1012.71643939697, 1024.068098030796, 11205.439728013649, 11209.887901120966, 11437.828432573519, 11577.94211028948, 11620.418979051014, 3706.4625629283605, 4416.823327066945, 4512.120136573337, 4536.79584418702, 4559.361689363492, 8056.798580035546, 9044.502552359552, 9088.182063614306, 9105.317101217302, 9131.908680913106, 5166.225066240094, 5171.663841850268, 5184.585233181337, 5184.766685499161, 5194.714290713971, 4340.696151269444, 4434.534373890695, 4793.161196790547, 4862.8784280392565, 4875.1224779540025, 3664.230511592542, 3667.578228503703, 3740.4202348636004, 3762.1347090169415, 3768.3593789055376, 1132.8810474900017, 1143.3425780176433, 1148.2880614019361, 1148.465963327057, 1149.9137564682683, 764.6903004283274, 811.3752410643772, 899.7885496908222, 921.8202450522218, 941.1717688434134, 5663.688497132697, 5707.686077265707, 5887.381824908409, 5938.732757025944, 6056.697165141725, 415.1365160466223, 417.14485305124373, 419.8698403494926, 424.1495800919137, 424.91501699660193, 3766.981165094157, 3786.9398360386285, 3931.862384816575, 3982.78094704794, 4055.0, 10387.84418233727, 10632.096271816827, 10734.677959661223, 10766.246362754531, 10767.78464430707, 10617.681469555926, 10714.51784669676, 10728.0, 10728.892711072946, 10746.570137194425, 7928.445008849325, 8050.718224862102, 8072.8385432291025, 8112.148224436349, 8174.814651875564, 5744.655320680772, 5762.6830524319885, 5813.157092221689, 5831.241938548132, 5892.175095486549, 9653.758656033655, 9873.950630246803, 9884.654037108667, 9941.602335906482, 9987.101160895554, 9861.753456163653, 10076.69769906904, 10115.797684046425, 10186.898131018595, 10211.387316761018, 6406.711697973509, 6529.053287273414, 6872.278410766798, 6940.9652951734915, 6971.372576468142, 8214.219649133323, 8274.420790544846, 8395.370347224105, 8404.285635721033, 8424.368172386972, 7357.963210183915, 7411.851762964819, 7502.0, 7565.0, 7619.771406857803, 7217.67520461591, 7310.780676579711, 7322.96338518304, 7439.665215065444, 7462.328390444669, 6830.180378354629, 6857.451403887577, 6880.311968803079, 6906.965465172642, 6921.1002569667635, 4928.236123400879, 4999.850004499871, 5031.723255220998, 5047.167217409086, 5062.164742817541, 4865.148598995091, 4988.184039210079, 5028.74856257193, 5120.974395128001, 5130.12787826078], "value": 4390.37159519656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3475213393798, 301.4182627528869, 307.445061663697, 310.9082820567932, 312.01714599013104, 4729.385179926613, 5079.517445842648, 5409.188621706746, 5450.582848459399, 5459.481349271813, 3967.7024223183234, 5251.86870328242, 5259.789608415659, 5271.42014378418, 5329.467053294668, 3397.813120278384, 4072.3891416287647, 4122.50529936408, 4130.318497447917, 4131.467595206101, 3938.468306778577, 4104.794760261975, 4125.535434920605, 4134.359174327984, 4141.7100802943805, 3639.672429481346, 3822.3310920588924, 4074.22589707956, 4083.3874918762126, 4113.259613269625, 3075.815451072943, 3850.7280704384266, 4044.413560033793, 4089.693273004507, 4111.09555897702, 3574.160072382988, 3591.9224232730076, 3592.1738000259825, 3593.9281214375565, 3605.7475976681644, 4193.937090943638, 4991.078484485496, 5179.948200517984, 5213.426523082458, 5229.607779416521, 3870.9806450967844, 4669.159551280768, 4670.883227919295, 4688.5545873142, 4693.741844198567, 4711.858644240679, 5580.218769372291, 5620.971895140539, 5640.830775076754, 5673.461021202979, 3776.7686543090454, 3837.9808100959594, 3884.4173373994126, 3930.410438434229, 3955.6835453163676, 4767.404074490689, 4796.736179510125, 4904.087405911698, 5542.115680668592, 5891.263592050994, 3254.4304746669236, 3984.960150398517, 3991.4012898064943, 3991.4212439196153, 4024.3158663027357, 3554.3779838528153, 3611.5124458198334, 4049.5747946465785, 4065.5121385433936, 4072.9592704073175, 3694.113412780913, 4365.9521714788225, 4582.931256031162, 4606.95393046072, 4625.814967401267, 5230.241614965808, 5668.404817494186, 5705.429457054344, 5714.685692286964, 5740.0, 1104.861892263467, 1195.940202989847, 1263.0, 1303.4069498378215, 1332.906696531253, 882.1090698394668, 896.9058248883904, 907.8229745199623, 907.8592818113071, 911.7902882337099, 5264.763085661154, 5323.813666521653, 5330.615059437285, 5336.439673834269, 5340.813071542478, 4906.730129842822, 5023.6985780853265, 5718.914216286759, 5747.137929310553, 5771.971140144273, 4441.977790111029, 4885.951140488621, 5122.590192784568, 5280.834857708322, 5379.704116273564, 2283.0068920019844, 2501.349649091213, 2586.4697736963876, 2593.81843270973, 2603.5183491054217, 4531.546845315442, 4728.645351598644, 4728.668993170445, 4798.448178459522, 5120.8719782005, 4519.7740112994215, 4828.1031381171015, 4946.653734238569, 5001.899582091934, 5029.396472423333, 4279.700420970565, 4360.732419142028, 4491.101779644019, 4896.35596777736, 5084.898302034013, 4079.816408261576, 4201.7899105045235, 4404.8107011106185, 4726.2501186307545, 4843.602416803705, 3995.5005624296964, 4040.616141466556, 4577.954220457753, 4725.0, 4794.280857871207, 5164.948350516597, 5299.099153143898, 6025.879482410415, 6106.32830388648, 6150.231221097363, 3442.9483557747153, 3671.9816400917825, 3949.3878448840474, 3952.584978577323, 3957.683385329109, 4502.617277531446, 5154.819581314636, 5877.970610146922, 5927.911081333869, 5956.404359564009, 4922.630802689884, 5662.943370566241, 5669.719361881753, 5675.744591493475, 5694.963338860821, 5672.241605102431, 5692.544596432358, 5700.548764031506, 5739.139129130664, 5755.280589926259, 5285.867853303698, 5536.7785288588, 5579.0946337563055, 5594.349666848371, 5594.41258667834, 5657.773689052392, 5662.0, 5690.662694266926, 5711.659139054432, 5734.541236701138, 4736.8105275788585, 5077.289179514797, 5518.530924871431, 5604.047311956896, 5623.240862483676], "value": 3965.193125475171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.2584286499176, 721.1166321256458, 726.9345758881697, 737.9372753315968, 747.0624366420142, 11409.771804563903, 15008.47470338537, 15107.942444028922, 15132.24338783062, 15162.39350425983, 12229.327386993711, 13987.860121398782, 14849.257537123154, 15044.473443429482, 15099.094054356747, 688.2463702246046, 786.7325109462781, 813.9418755617703, 860.096898256831, 862.4523427623442, 676.5940435738543, 690.2821066091259, 828.6850996621306, 865.6234537976001, 866.0559989611322, 872.6727477196051, 890.0387581412059, 890.6036813617943, 891.2201823404521, 897.0804924951943, 877.7630039889258, 889.621910687955, 892.3976315986715, 895.4224525181287, 896.8744375787395, 637.3403527349218, 637.4995628431659, 652.6377860287539, 656.3469347998772, 658.9703463344161, 14727.55817325482, 14843.406263749437, 14866.628334291621, 15034.774478382833, 15048.849511504854, 14077.64805879851, 14097.64755881101, 14113.364898579486, 14136.151830890076, 14287.285635718172, 10411.219158563137, 11670.708232294175, 11765.176437649368, 11855.525778968831, 11975.461104250242, 3725.4039353703547, 3743.9064023399633, 3774.981125094357, 3808.295465338921, 3843.3658446356317, 111860.0, 113570.86429135768, 114134.0, 114788.0, 114977.0, 10773.946130269298, 10954.835677464844, 10971.945140274247, 11041.558337666564, 11077.944610276896, 22118.778812211993, 22148.778512214994, 22171.22400715967, 22178.556428871656, 22234.777652223594, 6793.93206067933, 7696.153423123452, 7708.807279818049, 7909.723159689498, 7965.522068675898, 4082.408050832613, 4134.152498737752, 4212.789360531961, 4219.177260434247, 4271.551487093872, 3756.398976163801, 4006.559278479365, 4013.3578627419474, 4036.6367026967714, 4037.7375470594316, 616.2327901762335, 701.9684114214873, 708.0, 710.1442761472414, 724.576122968059, 558.7904535799075, 579.458206576852, 643.6878114114651, 663.4261363920174, 663.8937769956784, 7920.643571039317, 8758.47449153053, 9265.675701350556, 9407.247420206368, 9502.47736374506, 553.7037684838673, 562.4207066721284, 580.3789944759068, 613.8693011068339, 623.2859636000998, 3589.9820500897326, 3727.7390582658954, 3808.771473711586, 4311.9784401077795, 4624.398828152319, 142309.0, 156413.0, 157729.42270577376, 157742.0, 161518.1924090372, 98404.0, 110457.0, 122501.0, 127345.72654273339, 141288.0, 84611.0, 106255.93744062615, 108409.45795270974, 108538.45730771453, 109135.0, 9402.764930876783, 9901.653442129491, 9908.25688073383, 9925.950370248103, 9957.0, 63837.0424443643, 64872.37819054561, 65138.0, 65907.0, 66467.66766166138, 78785.818212728, 85557.57221213855, 87798.0, 95923.0, 97161.0851674451, 11478.426078696199, 12028.15802893789, 12735.29955852437, 12742.745145097231, 12924.353782311035, 13530.661733456742, 14286.0, 14290.28548572588, 14710.16122984627, 14883.627909302355, 11550.191486596193, 12958.287294198533, 13186.604401867959, 13689.45242190341, 14047.438102475786, 11681.532738690357, 13130.40913158891, 13470.66323341885, 13692.589222323346, 13721.294259842613, 12693.936530317289, 13123.868761312264, 13425.0, 13517.256550889402, 13781.767983235792, 10930.344179349264, 10937.289076210021, 11030.22788404804, 11144.275622084539, 11223.60717374888, 9371.062893710574, 11134.053605443629, 11139.772045590753, 11236.94381528087, 11327.660170194908], "value": 7683.948151585084, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 116.0, 97.0, 173.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 125.0, 117.0, 152.0, 112.0, 115.0, 123.0, 119.0, 143.0, 114.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 261.0, 230.0, 276.0, 238.0, 199.0, 198.0, 198.0, 192.0, 200.0], "value": 219.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 60.0, 59.0, 84.0, 62.0, 61.0, 61.0, 59.0, 83.0, 75.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 90.0, 105.0, 98.0, 104.0, 97.0, 70.0, 73.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 90.0, 114.0, 90.0, 86.0, 92.0, 89.0, 91.0, 130.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 170.0, 127.0, 103.0, 101.0, 101.0, 113.0, 110.0, 100.0, 100.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 100.0, 78.0, 84.0, 150.0, 102.0, 84.0, 142.0, 146.0, 91.0], "value": 106.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 55.0, 56.0, 56.0, 57.0, 56.0, 57.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 83.0, 78.0, 96.0, 97.0, 71.0, 69.0, 67.0, 90.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 88.0, 92.0, 91.0, 81.0, 96.0, 109.0, 110.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 146.0, 161.0, 161.0, 146.0, 151.0, 149.0, 151.0, 196.0, 175.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 175.0, 176.0, 177.0, 177.0, 176.0, 176.0, 162.0, 236.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 71.0, 71.0, 71.0, 67.0, 61.0, 85.0, 89.0], "value": 73.0, "unit": "score"}]}]} 14:16:12 INFO - Return code: 0 14:16:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:12 ERROR - # TBPL SUCCESS # 14:16:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:12 INFO - 2016-10-26 14:16:12.298 screenresolution[1674:10653] starting screenresolution argv=screenresolution get 14:16:12 INFO - 2016-10-26 14:16:12.301 screenresolution[1674:10653] Display 0: 1600x1200x32@60 14:16:12 INFO - 2016-10-26 14:16:12.306 screenresolution[1675:10656] starting screenresolution argv=screenresolution list 14:16:12 INFO - Available Modes on Display 0 14:16:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:12 INFO - Intel Iris: 14:16:12 INFO - Chipset Model: Intel Iris 14:16:12 INFO - Type: GPU 14:16:12 INFO - Bus: Built-In 14:16:12 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:12 INFO - Vendor: Intel (0x8086) 14:16:12 INFO - Device ID: 0x0a2e 14:16:12 INFO - Revision ID: 0x0009 14:16:12 INFO - Displays: 14:16:12 INFO - Display: 14:16:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:12 INFO - Display Serial Number: 1600x1200 60 14:16:12 INFO - Main Display: Yes 14:16:12 INFO - Mirror: Off 14:16:12 INFO - Online: Yes 14:16:12 INFO - Rotation: Supported 14:16:12 INFO - Return code: 0 14:16:12 INFO - Running post-action listener: _resource_record_post_action 14:16:12 INFO - [mozharness: 2016-10-26 21:16:12.550121Z] Finished run-tests step (success) 14:16:12 INFO - Running post-run listener: _resource_record_post_run 14:16:12 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 39725568; Write bytes: 712103424; Read time: 401; Write time: 1922 14:16:12 INFO - TinderboxPrint: CPU usage
54.6% 14:16:12 INFO - TinderboxPrint: I/O read bytes / time
39,725,568 / 401 14:16:12 INFO - TinderboxPrint: I/O write bytes / time
712,103,424 / 1,922 14:16:12 INFO - TinderboxPrint: CPU idle
2,200.4 (45.4%) 14:16:12 INFO - TinderboxPrint: CPU system
982.7 (20.3%) 14:16:12 INFO - TinderboxPrint: CPU user
1,658.6 (34.3%) 14:16:12 INFO - TinderboxPrint: Swap in / out
447,225,856 / 0 14:16:12 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413809152; Write bytes: 410159104; Read time: 31168; Write time: 788 14:16:12 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 30261760; Write bytes: 300342784; Read time: 287; Write time: 1130 14:16:13 INFO - Running post-run listener: _upload_blobber_files 14:16:13 INFO - Blob upload gear active. 14:16:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:14 INFO - (blobuploader) - INFO - Done attempting. 14:16:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:15 INFO - (blobuploader) - INFO - Done attempting. 14:16:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:17 INFO - (blobuploader) - INFO - Done attempting. 14:16:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:17 INFO - Return code: 0 14:16:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311f598a2ce8191bce8bfd44bdb66b14cbf0a87174988ae984f0ff33e79f0cb2e5429cdfc43dac8e6b117c7b04e64622a17cd653be41c12ffdf91cae1b948745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f2e3c978bc551a2769423a5897449f8d015b828170e8c25c49ff456a5c8305966934867612c9bca9842418e793bac8f5cc0e8059e06f717fc7ae4e48f98437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae05b8edbad31865eee047c3393880066d8ebf56e15db9ac3581eb6bc3fdc08ed65d5fbee8965d0e678e117763a9fb41d0e665ee95d0617b39fe54a0b0c9b85"} 14:16:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:17 INFO - Contents: 14:16:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/311f598a2ce8191bce8bfd44bdb66b14cbf0a87174988ae984f0ff33e79f0cb2e5429cdfc43dac8e6b117c7b04e64622a17cd653be41c12ffdf91cae1b948745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f2e3c978bc551a2769423a5897449f8d015b828170e8c25c49ff456a5c8305966934867612c9bca9842418e793bac8f5cc0e8059e06f717fc7ae4e48f98437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae05b8edbad31865eee047c3393880066d8ebf56e15db9ac3581eb6bc3fdc08ed65d5fbee8965d0e678e117763a9fb41d0e665ee95d0617b39fe54a0b0c9b85"} 14:16:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:17 INFO - Copying logs to upload dir... 14:16:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.831040 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-10-26 14:16:17.959669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:17.963461) ========= 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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/311f598a2ce8191bce8bfd44bdb66b14cbf0a87174988ae984f0ff33e79f0cb2e5429cdfc43dac8e6b117c7b04e64622a17cd653be41c12ffdf91cae1b948745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f2e3c978bc551a2769423a5897449f8d015b828170e8c25c49ff456a5c8305966934867612c9bca9842418e793bac8f5cc0e8059e06f717fc7ae4e48f98437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae05b8edbad31865eee047c3393880066d8ebf56e15db9ac3581eb6bc3fdc08ed65d5fbee8965d0e678e117763a9fb41d0e665ee95d0617b39fe54a0b0c9b85"} build_url:https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011055 build_url: 'https://queue.taskcluster.net/v1/task/IZGeiCGoQaClfuDxQEdBRQ/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/311f598a2ce8191bce8bfd44bdb66b14cbf0a87174988ae984f0ff33e79f0cb2e5429cdfc43dac8e6b117c7b04e64622a17cd653be41c12ffdf91cae1b948745", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5f2e3c978bc551a2769423a5897449f8d015b828170e8c25c49ff456a5c8305966934867612c9bca9842418e793bac8f5cc0e8059e06f717fc7ae4e48f98437", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bae05b8edbad31865eee047c3393880066d8ebf56e15db9ac3581eb6bc3fdc08ed65d5fbee8965d0e678e117763a9fb41d0e665ee95d0617b39fe54a0b0c9b85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:17.995701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:17.996014) ========= 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.r6ZXJiQZB8/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.kJtf05LuZm/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005150 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:16:18.043789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:18.044420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:16:18.044733) ========= ========= Total master_lag: 0.17 =========