builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0298 starttime: 1482357048.09 results: success (0) buildid: 20161221115353 builduid: 334bffdba84d4cd8965af2712ba8ac0f revision: d43a5a11c195d12ca3a3179855a6b50a05583311 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.094711) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.095150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.095426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.121615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.121933) ========= 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.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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-12-21 13:50:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-12-21 13:50:48 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136998 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.282427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.282766) ========= 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.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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.024678 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:48.333803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 13:50:48.337161) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d43a5a11c195d12ca3a3179855a6b50a05583311 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d43a5a11c195d12ca3a3179855a6b50a05583311 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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-12-21 13:50:48,436 truncating revision to first 12 chars 2016-12-21 13:50:48,437 Setting DEBUG logging. 2016-12-21 13:50:48,437 attempt 1/10 2016-12-21 13:50:48,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d43a5a11c195?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 13:50:49,513 unpacking tar archive at: mozilla-aurora-d43a5a11c195/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 13:50:49.691498) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:49.691831) ========= script_repo_revision: d43a5a11c195d12ca3a3179855a6b50a05583311 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:49.695241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:49.695511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 13:50:49.715293) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-21 13:50:49.715567) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:50:49 INFO - MultiFileLogger online at 20161221 13:50:49 in /builds/slave/test 13:50:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:50:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:49 INFO - {'append_to_log': False, 13:50:49 INFO - 'base_work_dir': '/builds/slave/test', 13:50:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:50:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:49 INFO - 'branch': 'Mozilla-Aurora', 13:50:49 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:49 INFO - 'config_files': ('talos/mac_config.py',), 13:50:49 INFO - 'default_actions': ('clobber', 13:50:49 INFO - 'read-buildbot-config', 13:50:49 INFO - 'download-and-extract', 13:50:49 INFO - 'populate-webroot', 13:50:49 INFO - 'create-virtualenv', 13:50:49 INFO - 'install', 13:50:49 INFO - 'run-tests'), 13:50:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:49 INFO - 'download_minidump_stackwalk': True, 13:50:49 INFO - 'download_symbols': 'ondemand', 13:50:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:49 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:49 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:49 INFO - 'installer_path': 'installer.exe', 13:50:49 INFO - 'log_level': 'info', 13:50:49 INFO - 'log_name': 'talos', 13:50:49 INFO - 'log_to_console': True, 13:50:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:49 INFO - 'opt_config_files': (), 13:50:49 INFO - 'pip_index': False, 13:50:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:49 INFO - 'cmd': ('bash', 13:50:49 INFO - '-c', 13:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:49 INFO - 'enabled': True, 13:50:49 INFO - 'halt_on_failure': False, 13:50:49 INFO - 'name': 'check_screen_resolution'},), 13:50:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:49 INFO - 'cmd': ('bash', 13:50:49 INFO - '-c', 13:50:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:49 INFO - 'enabled': True, 13:50:49 INFO - 'halt_on_failure': False, 13:50:49 INFO - 'name': 'check_screen_resolution'},), 13:50:49 INFO - 'run_cmd_checks_enabled': True, 13:50:49 INFO - 'sps_profile': False, 13:50:49 INFO - 'sps_profile_interval': 0, 13:50:49 INFO - 'suite': 'dromaeojs-e10s', 13:50:49 INFO - 'system_bits': '32', 13:50:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:49 INFO - 'title': 't-yosemite-r7-0298', 13:50:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:49 INFO - 'use_talos_json': True, 13:50:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:49 INFO - 'work_dir': 'build'} 13:50:49 INFO - [mozharness: 2016-12-21 21:50:49.922597Z] Running clobber step. 13:50:49 INFO - Running pre-action listener: _resource_record_pre_action 13:50:49 INFO - Running main action method: clobber 13:50:49 INFO - rmtree: /builds/slave/test/build 13:50:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:52 INFO - Running post-action listener: _resource_record_post_action 13:50:52 INFO - [mozharness: 2016-12-21 21:50:52.326243Z] Finished clobber step (success) 13:50:52 INFO - [mozharness: 2016-12-21 21:50:52.326396Z] Running read-buildbot-config step. 13:50:52 INFO - Running pre-action listener: _resource_record_pre_action 13:50:52 INFO - Running main action method: read_buildbot_config 13:50:52 INFO - Using buildbot properties: 13:50:52 INFO - { 13:50:52 INFO - "project": "", 13:50:52 INFO - "product": "firefox", 13:50:52 INFO - "script_repo_revision": "production", 13:50:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:50:52 INFO - "repository": "", 13:50:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:50:52 INFO - "buildid": "20161221115353", 13:50:52 INFO - "pgo_build": "False", 13:50:52 INFO - "basedir": "/builds/slave/test", 13:50:52 INFO - "buildnumber": 12, 13:50:52 INFO - "slavename": "t-yosemite-r7-0298", 13:50:52 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:50:52 INFO - "platform": "yosemite_r7", 13:50:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:50:52 INFO - "branch": "mozilla-aurora", 13:50:52 INFO - "repo_path": "releases/mozilla-aurora", 13:50:52 INFO - "revision": "d43a5a11c195d12ca3a3179855a6b50a05583311", 13:50:52 INFO - "stage_platform": "macosx64", 13:50:52 INFO - "builduid": "334bffdba84d4cd8965af2712ba8ac0f", 13:50:52 INFO - "slavebuilddir": "test" 13:50:52 INFO - } 13:50:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 13:50:52 INFO - Running post-action listener: _resource_record_post_action 13:50:52 INFO - [mozharness: 2016-12-21 21:50:52.329955Z] Finished read-buildbot-config step (success) 13:50:52 INFO - [mozharness: 2016-12-21 21:50:52.330084Z] Running download-and-extract step. 13:50:52 INFO - Running pre-action listener: _resource_record_pre_action 13:50:52 INFO - Running main action method: download_and_extract 13:50:52 INFO - mkdir: /builds/slave/test/build/tests 13:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:52 INFO - trying https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 13:50:53 INFO - Downloaded 1199 bytes. 13:50:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 13:50:53 INFO - Using the following test package requirements: 13:50:53 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:53 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 13:50:53 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 13:50:53 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'jsshell-mac.zip'], 13:50:53 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 13:50:53 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 13:50:53 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 13:50:53 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 13:50:53 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 13:50:53 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 13:50:53 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 13:50:53 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:50:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:50:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:50:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:50:53 INFO - Http code: 200 13:50:53 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 13:50:53 INFO - x-amz-cf-id: wx-CVY_e6yGs409RtPoF5tbwAYD5AmeG7aSSKvJ4lwkjvFkXNVWb_g== 13:50:53 INFO - x-amz-version-id: gSEvYMJ_KBl2Lst8J3.SJ5w1txR4vlfX 13:50:54 INFO - Expected file size: 16269587 13:50:54 INFO - Obtained file size: 16269587 13:51:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:51:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 13:51:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:51:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 13:51:01 INFO - Http code: 200 13:51:01 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:51:01 INFO - x-amz-cf-id: mxqj7DIQFOxKR7M2KyRE1p_x0WgKo92bJGiEaaiN6H-wngDDOsl35Q== 13:51:01 INFO - x-amz-version-id: gSEvYMJ_KBl2Lst8J3.SJ5w1txR4vlfX 13:51:01 INFO - Expected file size: 16269587 13:51:01 INFO - Obtained file size: 16269587 13:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 13:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 13:51:09 INFO - Http code: 200 13:51:09 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:51:09 INFO - x-amz-cf-id: 7nTAGUz-vYgIGH56wSv8nbzRWhaPTx3rcogWGd_PKRGS3w8aRPnojQ== 13:51:09 INFO - x-amz-version-id: xl1WapBsMA7q64M_g1IN7eokAPdx7EaX 13:51:10 INFO - Expected file size: 14409038 13:51:10 INFO - Obtained file size: 14409038 13:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:10 INFO - trying https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:51:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 13:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 13:51:13 INFO - Downloaded 109757866 bytes. 13:51:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:51:13 INFO - mkdir: /builds/slave/test/properties 13:51:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:13 INFO - Contents: 13:51:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 13:51:13 INFO - Running post-action listener: _resource_record_post_action 13:51:13 INFO - Running post-action listener: set_extra_try_arguments 13:51:13 INFO - [mozharness: 2016-12-21 21:51:13.869928Z] Finished download-and-extract step (success) 13:51:13 INFO - [mozharness: 2016-12-21 21:51:13.870079Z] Running populate-webroot step. 13:51:13 INFO - Running pre-action listener: _resource_record_pre_action 13:51:13 INFO - Running main action method: populate_webroot 13:51:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:13 INFO - '--tppagecycles', 13:51:13 INFO - '7'], 13:51:13 INFO - 'tests': ['tsvgm']}}, 13:51:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['damp', 'tps']}, 13:51:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'tests': ['damp', 'tps']}, 13:51:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['dromaeo_dom']}, 13:51:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['basic_compositor_video']}, 13:51:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['a11yr', 13:51:13 INFO - 'ts_paint', 13:51:13 INFO - 'tpaint', 13:51:13 INFO - 'sessionrestore', 13:51:13 INFO - 'sessionrestore_no_auto_restore', 13:51:13 INFO - 'tabpaint']}, 13:51:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['tsvgx', 13:51:13 INFO - 'tsvgr_opacity', 13:51:13 INFO - 'tart', 13:51:13 INFO - 'tscrollx', 13:51:13 INFO - 'cart']}, 13:51:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:13 INFO - 'tsvgr_opacity', 13:51:13 INFO - 'tart', 13:51:13 INFO - 'tscrollx', 13:51:13 INFO - 'cart']}, 13:51:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-e10s'], 13:51:13 INFO - 'tests': ['tp5o']}, 13:51:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'tests': ['tp5o']}, 13:51:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'talos_options': ['--disable-e10s', 13:51:13 INFO - '--xperf_path', 13:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:13 INFO - 'tests': ['tp5n']}, 13:51:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:13 INFO - 'talos_options': ['--xperf_path', 13:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:13 INFO - 'tests': ['tp5n']}}, 13:51:13 INFO - 'talos.zip': {'path': '', 13:51:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:13 INFO - Running post-action listener: _resource_record_post_action 13:51:13 INFO - [mozharness: 2016-12-21 21:51:13.889216Z] Finished populate-webroot step (success) 13:51:13 INFO - [mozharness: 2016-12-21 21:51:13.889371Z] Running create-virtualenv step. 13:51:13 INFO - Running pre-action listener: _resource_record_pre_action 13:51:13 INFO - Running main action method: create_virtualenv 13:51:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:13 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:51:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:14 INFO - Using real prefix '/tools/python27' 13:51:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:17 INFO - Installing pip.................done. 13:51:17 INFO - Return code: 0 13:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:17 INFO - Reading from file tmpfile_stdout 13:51:17 INFO - Output received: 13:51:17 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:51:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51:17 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:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:17 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:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:17 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:17 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:51:17 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:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:17 INFO - 'HOME': '/Users/cltbld', 13:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:17 INFO - 'LOGNAME': 'cltbld', 13:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:17 INFO - 'MOZ_NO_REMOTE': '1', 13:51:17 INFO - 'NO_EM_RESTART': '1', 13:51:17 INFO - 'PAGER': '/bin/cat', 13:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:17 INFO - 'PWD': '/builds/slave/test', 13:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:17 INFO - 'SHELL': '/bin/bash', 13:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:17 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:17 INFO - 'USER': 'cltbld', 13:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:17 INFO - 'XPC_FLAGS': '0x0', 13:51:17 INFO - 'XPC_SERVICE_NAME': '0', 13:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 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:51:18 INFO - Cleaning up... 13:51:18 INFO - Return code: 0 13:51:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51:18 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:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:18 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:18 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:51:18 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:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:18 INFO - 'HOME': '/Users/cltbld', 13:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:18 INFO - 'LOGNAME': 'cltbld', 13:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:18 INFO - 'MOZ_NO_REMOTE': '1', 13:51:18 INFO - 'NO_EM_RESTART': '1', 13:51:18 INFO - 'PAGER': '/bin/cat', 13:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:18 INFO - 'PWD': '/builds/slave/test', 13:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:18 INFO - 'SHELL': '/bin/bash', 13:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:18 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:18 INFO - 'USER': 'cltbld', 13:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:18 INFO - 'XPC_FLAGS': '0x0', 13:51:18 INFO - 'XPC_SERVICE_NAME': '0', 13:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:18 INFO - Downloading/unpacking psutil>=3.1.1 13:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:21 INFO - Installing collected packages: psutil 13:51:21 INFO - Running setup.py install for psutil 13:51:21 INFO - building 'psutil._psutil_osx' extension 13:51:21 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:51:22 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:51:22 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:51:22 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:51:22 INFO - building 'psutil._psutil_posix' extension 13:51:22 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:51:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:22 INFO - ^ 13:51:22 INFO - 1 warning generated. 13:51:22 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:51:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:22 INFO - Successfully installed psutil 13:51:22 INFO - Cleaning up... 13:51:22 INFO - Return code: 0 13:51:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:22 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:51:22 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:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:23 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:23 INFO - 'USER': 'cltbld', 13:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:23 INFO - 'XPC_FLAGS': '0x0', 13:51:23 INFO - 'XPC_SERVICE_NAME': '0', 13:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:23 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:51:23 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:51:23 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:51:23 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:51:23 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:51:23 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:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:25 INFO - Installing collected packages: mozsystemmonitor 13:51:25 INFO - Running setup.py install for mozsystemmonitor 13:51:26 INFO - Successfully installed mozsystemmonitor 13:51:26 INFO - Cleaning up... 13:51:26 INFO - Return code: 0 13:51:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:26 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:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:26 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:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:26 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:26 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:51:26 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:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:26 INFO - 'HOME': '/Users/cltbld', 13:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:26 INFO - 'LOGNAME': 'cltbld', 13:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:26 INFO - 'MOZ_NO_REMOTE': '1', 13:51:26 INFO - 'NO_EM_RESTART': '1', 13:51:26 INFO - 'PAGER': '/bin/cat', 13:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:26 INFO - 'PWD': '/builds/slave/test', 13:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:26 INFO - 'SHELL': '/bin/bash', 13:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:26 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:26 INFO - 'USER': 'cltbld', 13:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:26 INFO - 'XPC_FLAGS': '0x0', 13:51:26 INFO - 'XPC_SERVICE_NAME': '0', 13:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51:29 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:51:29 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:51:29 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:51:29 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:51:29 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:51:29 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:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:29 INFO - warning: no files found matching '*.txt' 13:51:29 INFO - no previously-included directories found matching 'build' 13:51:29 INFO - no previously-included directories found matching 'dist' 13:51:29 INFO - no previously-included directories found matching '.git*' 13:51:29 INFO - Installing collected packages: jsonschema, functools32 13:51:29 INFO - Running setup.py install for functools32 13:51:29 INFO - warning: no files found matching '*.txt' 13:51:29 INFO - no previously-included directories found matching 'build' 13:51:29 INFO - no previously-included directories found matching 'dist' 13:51:29 INFO - no previously-included directories found matching '.git*' 13:51:29 INFO - Successfully installed jsonschema functools32 13:51:29 INFO - Cleaning up... 13:51:29 INFO - Return code: 0 13:51:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:29 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:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:29 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:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:29 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:29 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:51:29 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:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:29 INFO - 'HOME': '/Users/cltbld', 13:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:29 INFO - 'LOGNAME': 'cltbld', 13:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:29 INFO - 'MOZ_NO_REMOTE': '1', 13:51:29 INFO - 'NO_EM_RESTART': '1', 13:51:29 INFO - 'PAGER': '/bin/cat', 13:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:29 INFO - 'PWD': '/builds/slave/test', 13:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:29 INFO - 'SHELL': '/bin/bash', 13:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:29 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:29 INFO - 'USER': 'cltbld', 13:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:29 INFO - 'XPC_FLAGS': '0x0', 13:51:29 INFO - 'XPC_SERVICE_NAME': '0', 13:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:30 INFO - Cleaning up... 13:51:30 INFO - Return code: 0 13:51:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:30 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:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 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:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:30 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:30 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:51:30 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:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:30 INFO - 'HOME': '/Users/cltbld', 13:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:30 INFO - 'LOGNAME': 'cltbld', 13:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:30 INFO - 'MOZ_NO_REMOTE': '1', 13:51:30 INFO - 'NO_EM_RESTART': '1', 13:51:30 INFO - 'PAGER': '/bin/cat', 13:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:30 INFO - 'PWD': '/builds/slave/test', 13:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:30 INFO - 'SHELL': '/bin/bash', 13:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:30 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:30 INFO - 'USER': 'cltbld', 13:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:30 INFO - 'XPC_FLAGS': '0x0', 13:51:30 INFO - 'XPC_SERVICE_NAME': '0', 13:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:30 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:51:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51: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:51: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:51: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:51: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:51: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:51: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:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51: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:51: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:51: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:51: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:51: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:51: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:51:34 INFO - Downloading docopt-0.6.1.tar.gz 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:34 INFO - Running setup.py install for blobuploader 13:51:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:34 INFO - Running setup.py install for requests 13:51:34 INFO - Running setup.py install for docopt 13:51:35 INFO - Successfully installed blobuploader requests docopt 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:35 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:51:35 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:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-Oz02Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-mGlDvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-30A8fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-mWzTE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-y4zEmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:35 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-no43jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-qeNmWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-uZPxrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-xrdoZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-V2_bCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-Hxt5fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-5JjcmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-DTZtML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-oyoK9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:36 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-CTboYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:37 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-Fd4pQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:37 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-UvqFZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:37 INFO - Running setup.py install for manifestparser 13:51:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:37 INFO - Running setup.py install for mozcrash 13:51:37 INFO - Running setup.py install for mozdebug 13:51:37 INFO - Running setup.py install for mozdevice 13:51:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:37 INFO - Running setup.py install for mozfile 13:51:38 INFO - Running setup.py install for mozhttpd 13:51:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozinfo 13:51:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozInstall 13:51:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozleak 13:51:38 INFO - Running setup.py install for mozlog 13:51:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for moznetwork 13:51:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:38 INFO - Running setup.py install for mozprocess 13:51:39 INFO - Running setup.py install for mozprofile 13:51:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozrunner 13:51:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozscreenshot 13:51:39 INFO - Running setup.py install for moztest 13:51:39 INFO - Running setup.py install for mozversion 13:51:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:39 INFO - Cleaning up... 13:51:39 INFO - Return code: 0 13:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:39 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:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:39 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:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:39 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:39 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:51:39 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:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:39 INFO - 'HOME': '/Users/cltbld', 13:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:39 INFO - 'LOGNAME': 'cltbld', 13:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:39 INFO - 'MOZ_NO_REMOTE': '1', 13:51:39 INFO - 'NO_EM_RESTART': '1', 13:51:39 INFO - 'PAGER': '/bin/cat', 13:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:39 INFO - 'PWD': '/builds/slave/test', 13:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:39 INFO - 'SHELL': '/bin/bash', 13:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:39 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:39 INFO - 'USER': 'cltbld', 13:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:39 INFO - 'XPC_FLAGS': '0x0', 13:51:39 INFO - 'XPC_SERVICE_NAME': '0', 13:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-GKlcw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-OqAQ6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-rMJ95v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-Tf57Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-_xXqIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-YcNgkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-3V62kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-BHS6oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:40 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:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:40 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-98_e1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-Jc0gIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-VrRjv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-sCf39b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-p6fIaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-gikuhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-em7iSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-wZHohb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:41 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:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:41 INFO - Running setup.py (path:/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/pip-9VecL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:41 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:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:41 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:51:41 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:51:41 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:51:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51: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:51: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:51: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:51: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:51: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:51: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:51:44 INFO - Downloading blessings-1.6.tar.gz 13:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:44 INFO - Installing collected packages: blessings 13:51:44 INFO - Running setup.py install for blessings 13:51:45 INFO - Successfully installed blessings 13:51:45 INFO - Cleaning up... 13:51:45 INFO - Return code: 0 13:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:45 INFO - Reading from file tmpfile_stdout 13:51:45 INFO - Current package versions: 13:51:45 INFO - blessings == 1.6 13:51:45 INFO - blobuploader == 1.2.4 13:51:45 INFO - docopt == 0.6.1 13:51:45 INFO - functools32 == 3.2.3-2 13:51:45 INFO - jsonschema == 2.5.1 13:51:45 INFO - manifestparser == 1.1 13:51:45 INFO - mozInstall == 1.12 13:51:45 INFO - mozcrash == 1.0 13:51:45 INFO - mozdebug == 0.1 13:51:45 INFO - mozdevice == 0.48 13:51:45 INFO - mozfile == 1.2 13:51:45 INFO - mozhttpd == 0.7 13:51:45 INFO - mozinfo == 0.9 13:51:45 INFO - mozleak == 0.1 13:51:45 INFO - mozlog == 3.4 13:51:45 INFO - moznetwork == 0.27 13:51:45 INFO - mozprocess == 0.23 13:51:45 INFO - mozprofile == 0.28 13:51:45 INFO - mozrunner == 6.13 13:51:45 INFO - mozscreenshot == 0.1 13:51:45 INFO - mozsystemmonitor == 0.3 13:51:45 INFO - moztest == 0.7 13:51:45 INFO - mozversion == 1.4 13:51:45 INFO - psutil == 3.1.1 13:51:45 INFO - requests == 1.2.3 13:51:45 INFO - wsgiref == 0.1.2 13:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:45 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:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 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:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 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 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:45 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:51:45 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:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:45 INFO - 'HOME': '/Users/cltbld', 13:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:45 INFO - 'LOGNAME': 'cltbld', 13:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:45 INFO - 'MOZ_NO_REMOTE': '1', 13:51:45 INFO - 'NO_EM_RESTART': '1', 13:51:45 INFO - 'PAGER': '/bin/cat', 13:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:45 INFO - 'PWD': '/builds/slave/test', 13:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:45 INFO - 'SHELL': '/bin/bash', 13:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:45 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:45 INFO - 'USER': 'cltbld', 13:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:45 INFO - 'XPC_FLAGS': '0x0', 13:51:45 INFO - 'XPC_SERVICE_NAME': '0', 13:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 INFO - Cleaning up... 13:51:46 INFO - Return code: 0 13:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107685490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd89cd3a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, '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.2sI7uccEvF/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.8QVFOINisu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:46 INFO - 'HOME': '/Users/cltbld', 13:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:46 INFO - 'LOGNAME': 'cltbld', 13:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:46 INFO - 'MOZ_NO_REMOTE': '1', 13:51:46 INFO - 'NO_EM_RESTART': '1', 13:51:46 INFO - 'PAGER': '/bin/cat', 13:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:46 INFO - 'PWD': '/builds/slave/test', 13:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:46 INFO - 'SHELL': '/bin/bash', 13:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:51:46 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:46 INFO - 'USER': 'cltbld', 13:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:46 INFO - 'XPC_FLAGS': '0x0', 13:51:46 INFO - 'XPC_SERVICE_NAME': '0', 13:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:46 INFO - Cleaning up... 13:51:46 INFO - Return code: 0 13:51:46 INFO - Running post-action listener: _resource_record_post_action 13:51:46 INFO - Running post-action listener: _start_resource_monitoring 13:51:46 INFO - Starting resource monitoring. 13:51:46 INFO - [mozharness: 2016-12-21 21:51:46.494036Z] Finished create-virtualenv step (success) 13:51:46 INFO - [mozharness: 2016-12-21 21:51:46.495012Z] Running install step. 13:51:46 INFO - Running pre-action listener: _resource_record_pre_action 13:51:46 INFO - Running main action method: install 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:46 INFO - Reading from file tmpfile_stdout 13:51:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:46 INFO - Reading from file tmpfile_stdout 13:51:46 INFO - Output received: 13:51:46 INFO - Usage: mozinstall [options] installer 13:51:46 INFO - Options: 13:51:46 INFO - -h, --help show this help message and exit 13:51:46 INFO - -d DEST, --destination=DEST 13:51:46 INFO - Directory to install application into. [default: 13:51:46 INFO - "/builds/slave/test"] 13:51:46 INFO - --app=APP Application being installed. [default: firefox] 13:51:46 INFO - mkdir: /builds/slave/test/build/application 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:52:17 INFO - Reading from file tmpfile_stdout 13:52:17 INFO - Output received: 13:52:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:52:17 INFO - Running post-action listener: _resource_record_post_action 13:52:17 INFO - [mozharness: 2016-12-21 21:52:17.895440Z] Finished install step (success) 13:52:17 INFO - [mozharness: 2016-12-21 21:52:17.895589Z] Running run-tests step. 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: run_tests 13:52:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:17 INFO - 2016-12-21 13:52:17.909 screenresolution[1629:7362] starting screenresolution argv=screenresolution get 13:52:17 INFO - 2016-12-21 13:52:17.912 screenresolution[1629:7362] Display 0: 1600x1200x32@60 13:52:17 INFO - 2016-12-21 13:52:17.918 screenresolution[1630:7365] starting screenresolution argv=screenresolution list 13:52:17 INFO - Available Modes on Display 0 13:52:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:18 INFO - Intel Iris: 13:52:18 INFO - Chipset Model: Intel Iris 13:52:18 INFO - Type: GPU 13:52:18 INFO - Bus: Built-In 13:52:18 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:18 INFO - Vendor: Intel (0x8086) 13:52:18 INFO - Device ID: 0x0a2e 13:52:18 INFO - Revision ID: 0x0009 13:52:18 INFO - Displays: 13:52:18 INFO - Display: 13:52:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:18 INFO - Display Serial Number: 1600x1200 60 13:52:18 INFO - Main Display: Yes 13:52:18 INFO - Mirror: Off 13:52:18 INFO - Online: Yes 13:52:18 INFO - Rotation: Supported 13:52:18 INFO - Return code: 0 13:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:18 INFO - Python 2.7.3 13:52:18 INFO - Return code: 0 13:52:18 INFO - grabbing minidump binary from tooltool 13:52:18 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:52:18 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 0x107499d30>, '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 0x1072ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107491b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:18 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:52:18 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:52:18 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:52:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:18 INFO - Return code: 0 13:52:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0298', '--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:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0298 --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:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2sI7uccEvF/Render', 13:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:18 INFO - 'HOME': '/Users/cltbld', 13:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:18 INFO - 'LOGNAME': 'cltbld', 13:52:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:18 INFO - 'MOZ_NO_REMOTE': '1', 13:52:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:18 INFO - 'NO_EM_RESTART': '1', 13:52:18 INFO - 'PAGER': '/bin/cat', 13:52:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:18 INFO - 'PWD': '/builds/slave/test', 13:52:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:18 INFO - 'SHELL': '/bin/bash', 13:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8QVFOINisu/Listeners', 13:52:18 INFO - 'TMPDIR': '/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/', 13:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:18 INFO - 'USER': 'cltbld', 13:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:18 INFO - 'XPC_FLAGS': '0x0', 13:52:18 INFO - 'XPC_SERVICE_NAME': '0', 13:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0298', '--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:52:18 INFO - mozversion application_buildid: 20161221115353 13:52:18 INFO - mozversion application_changeset: d43a5a11c195d12ca3a3179855a6b50a05583311 13:52:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:52:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:18 INFO - mozversion application_name: Firefox 13:52:18 INFO - mozversion application_remotingname: firefox-dev 13:52:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:18 INFO - mozversion application_vendor: Mozilla 13:52:18 INFO - mozversion application_version: 52.0a2 13:52:18 INFO - mozversion platform_buildid: 20161221115353 13:52:18 INFO - mozversion platform_changeset: d43a5a11c195d12ca3a3179855a6b50a05583311 13:52:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:52:18 INFO - mozversion platform_version: 52.0a2 13:52:18 INFO - using testdate: 1482357138 13:52:18 INFO - actual date: 1482357138 13:52:18 INFO - starting webserver on 'localhost:49243' 13:52:18 INFO - SUITE-START | Running 2 tests 13:52:18 INFO - TEST-START | dromaeo_css 13:52:18 INFO - operating with platform_type : mac_ 13:52:18 INFO - Initialising browser for dromaeo_css test... 13:52:18 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpMkhpUU/profile http://localhost:49243/getInfo.html) 13:52:21 INFO - PROCESS | 1640 | 2016-12-21 13:52:21.634 plugin-container[1642:7541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 13:52:21 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:21 INFO - PROCESS | 1640 | 2016-12-21 13:52:21.637 plugin-container[1642:7541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 13:52:21 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:21 INFO - PROCESS | 1640 | 2016-12-21 13:52:21.637 plugin-container[1642:7541] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:21 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 13:52:21 INFO - PROCESS | 1640 | colorDepth:24 13:52:21 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 13:52:21 INFO - PROCESS | 1640 | __metrics 13:52:21 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 13:52:22 INFO - TEST-INFO | 1640: exit 0 13:52:22 INFO - Browser initialized. 13:52:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:22 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpMkhpUU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:25 INFO - PROCESS | 1643 | 2016-12-21 13:52:25.093 plugin-container[1644:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:52:25 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:25 INFO - PROCESS | 1643 | 2016-12-21 13:52:25.094 plugin-container[1644:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 13:52:25 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:52:25 INFO - PROCESS | 1643 | 2016-12-21 13:52:25.094 plugin-container[1644:7671] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:52:34 INFO - PROCESS | 1643 | RSS: Main: 229048320 13:52:34 INFO - PROCESS | 1643 | 13:53:24 INFO - PROCESS | 1643 | 1482357204405 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:55:38 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 13:55:40 INFO - PROCESS | 1643 | RSS: Main: 233316352 13:55:40 INFO - PROCESS | 1643 | 13:58:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:58:43 INFO - PROCESS | 1643 | RSS: Main: 243916800 13:58:43 INFO - PROCESS | 1643 | 14:01:45 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 14:01:45 INFO - PROCESS | 1643 | RSS: Main: 246689792 14:01:45 INFO - PROCESS | 1643 | 14:04:47 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 14:04:48 INFO - PROCESS | 1643 | RSS: Main: 245964800 14:04:48 INFO - PROCESS | 1643 | 14:07:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 14:07:51 INFO - PROCESS | 1643 | RSS: Main: 249352192 14:07:51 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 14:10:54 INFO - PROCESS | 1643 | RSS: Main: 250777600 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | __start_tp_report 14:10:54 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:10:54 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:10:54 INFO - PROCESS | 1643 | |i|pagename|runs| 14:10:54 INFO - PROCESS | 1643 | |0;dojo.html;3330.117518857503;3353.329334133174;3372.8482218300173;3373.460246360583;3382.27281134556;5468.453154684529;5518.2550355702015;5532.419095994923;5536.916946245799;5548.500634942854;5530.336359636849;5568.081266591008;5600;5604.3835178130375;5670.8015219467325;4217.325227963511;4260.169266992938;4750.954789946223;5100.990415654772;5155.355580552431;4309.245881970643;4659.906801863961;4778.952210477885;5203.349581302337;5222.242774797652;4222.345536441856;5024.196128619422;5031.849044528652;5155.664881782691;5190.169572868342;5079.060373830853;5106.9489305106845;5126.256692779563;5137.229415587654;5148.459411761767;4122.690798190148;5083.11045567028;5098.898022039575;5136.101182293121;5143.819966301199;5552.167174923753;5559.972200139014;5647.152927060933;5648.604597678123;5718.485336319751;5876.500497457721;5930.851728706817;5989.401059893976;5999.950008748451;6107.664078475682;6176.474999624992;6179.412955769195;6196.659183744892;6200.596961197508;6204.069389591552;5646.181303710939;5649.71751412436;5653.9151912721345;5658.943410565842;5664.0937450007805;6118.832384214075;6146.078088286703;6175.166352542439;6235.594686345373;6312.147860038928;5982.40175982407;5986.281646202484;6006.279246490449;6012.699365031818;6047.546434017467;6121.265448146251;6146.5390095743;6155.045967874987;6159;6168.9691551541955;5746.109353050284;5887.1463637772285;5892.941070589325;6001.459868611846;6064.605800622945;5944.851378715567;5960.940390596039;5975.40245975399;5993;6005.819825405245;4564.566366195206;4759.881002974953;4785.401824771903;4797.64017698674;4805.8558243252755;3704.6480584344445;4156.937645935313;4292.141571685675;4357.063231405263;4362.498312694017;5653.208550802891;5753.769849205984;5794.652320860761;5800.767969281266;5868.4424979626865;5999.670018149044;6192.59748116371;6195.039768835838;6213.844653883689;6217.160683307786;5663.546916246691;5741.425857414309;5751.913721294184;5771.7114144293455;5776.191333213354;5293.417724050351;5313.628046036741;5323.0684630190335;5341.332333458317;5355.919661205085;5509.972450137724;6316.147320111818;6324.936750632435;6338.429541341301;6344.397282258178;6010.1285313628405;6034.788782392595;6058.848528786815;6115.027386288435;6210.596311239936;6226.221722284715;6260.843478913063;6266.122742816101;6304.747810087545;6311.90532142009;5994.490468310242;6007.519398448201;6011.338752737282;6040.214772079602;6076.118962750288;6056.0915862619195;6056.152138700498;6142.293636231891;6149.385061493815;6183.412575805291;5646.435356464321;5714.9142762857755;5754.53963682896;5793.913091303718;5921;5620.578456615852;5688.687122208153;5729.197912292366;5747.856303592276;5767.5674324425;4604.907901842012;5024.296598476143;5458.754356054066;5603.411641777718;5621.184928185472;4757.738324392053;5694.886102278014;5706.144078388275;5759.193712880116;5795.478406943395;5715.657060576379;5745.339285981999;5751.568632352507;5754.5684073695475;5779.7110144493445 14:10:54 INFO - PROCESS | 1643 | |1;ext.html;425.22608851889555;497.70884032840786;513.8304359561345;526.9461077844311;552.8666234219849;37586.43620345697;39147.80426097869;39324.820255392384;39328.803355983255;39406.21187576251;33233.83383083081;40606.7969660152;40682.7965860171;40689.38965915514;40766.388504172384;9387.624495020207;9543.33196676233;9545.236381089531;9548.045195480467;9578.808423831519;9329.72010839676;9428.575714092882;9432.669856555021;9434.43393396395;9440.905590944105;9314.115159059878;9413.246940244799;9442.858357124649;9443.150116489514;9493.572789224501;9343.205827504671;9423.905760942405;9432.811343773155;9443.244540436748;9481.146696797321;9291.256699464027;9376.343655944087;9452.57463414148;9455.14903658674;9457.763555911088;38738;39009;39038.414423783666;39046.804765976274;39145.60854391448;3322.368749937504;3326.3347330533747;3348.380549598308;3873.094763104621;3880.1075752577067;28590.142295731162;28681.56977645337;29613.815447382294;29986.95045673391;30111.849440752874;3168.936621267585;3244.902652920416;3248.4640034394533;3249.78876373035;3307.933841323184;415351;421635.891820542;422749;423373;423375;55420.89158216813;55919;55929.16106258409;55984.600384989884;56054.43945560574;57428;57873.842523150146;58227.4177258222;58546;58695.41304586985;15403.537893863202;15606.687866242839;15646.765298520531;15655.608609784618;15672.294746736425;11764.294142351486;11851.46668399924;11942.34317112567;11947.940260298643;12012.399380030964;14691.971561990558;14914.254287285592;15296.311665975058;15322.850786190857;15338.539843804481;3222.2910959588853;5862.443067908542;6788.978904387599;6864.141982252218;6866.828329291708;823.6458322921202;843.6372359885186;879.6393478673713;962.7544976031207;964.6623681711345;23217.419564511023;29179.270518237216;29268;29364.559531607043;29795.808167673484;891.4562117108559;979.1481411172183;1021.9320809753825;1044.1490185498794;1055.672741450153;11771.646850594496;11927.522899084113;15221.923890380698;15454.845451545341;15464.613384665248;660533;665133;665730;667632;672278;55383.169252461244;55520;55710.72144639332;55897.44102559004;56160.43839561552;1118.424011634009;1205.9336736479577;1223.806788381339;1364.8635136486273;1392.6518370407398;25128.874355628104;26830;28212.71787282101;28500.287492812844;29399.706002939696;47787.04425911532;47819.28271075867;47907.76046119747;48237.75881120572;48371.5162848367;606601;609304;610096;611787;611842;21635.567288653823;26137.477250455264;26178.607320890584;26190.34524136912;26204.606930896432;37268.813655931546;44393.6788586665;44554.77722611496;44961.550384495735;45006.324905127105;36403.27193456169;36569.26861462809;37101.443478347304;38159.61840381672;38392.2321553573;36840.07899802527;37138.814305928296;37530.06174845542;37739;38124.61875381211;30748.69251307548;36555;36620.45069323909;36671;37170.25659486741;32034.67965320317;33538;33849.661503384654;33905.49141762826;33988;25098.62352064684;25140.748592514574;25174.62238066467;25551.744482554936;25692.229233123035 14:10:54 INFO - PROCESS | 1643 | |2;jquery.html;366.44300662992237;368.23591048574207;376.1180032823029;379.8689452139012;388.4833171881398;18541.629167416642;19098.809011909878;19795.50511237218;19818.900905495488;19985.101415365552;18542.814571854276;19163.137658805354;19189.904050479727;19785.604287914233;19798.40604781859;5312.043832110228;5387.488188622095;5492.5605951523985;5504.587155963319;5989.311229208632;3844.7693138411787;5995.490383317423;6013.729382177812;6056.576039677225;6062.151298818169;4034.213328400963;5807.796727114552;6063.878722425548;6108.908366374508;6136.294326152482;6002.8799424011495;6076.756929722806;6079.240094988127;6111.694415279218;6144.784932527385;5933.525317974551;5950.107483877409;5985.311689155759;5994.100884867261;6008.218931538872;13037.739245215043;23407.648885266735;23517.41206469852;24107.39731506709;24160.516789664285;2160.7947245011856;2164.9567008659737;2179.204590324536;2550.846949183055;2716.953972720497;10222.386656800616;10375.377477351307;12108.697282567919;14453.32934758233;15106.622334441618;1604.374294025331;1811.3026484803313;1875.22178296007;1880.5204672808484;1884.4064119802356;116880;118663;118952;121139.39430302792;121570;10022.849657255147;10285.43430111351;11348.31910085381;11469.88530114705;11550;14590.270486475634;14663.120212787268;14667.48663796762;14689.485867994568;14709.705805884036;8224.506529608243;8437.873431898526;8513.063563008063;8609.913900861036;8653.913460865437;7758.14660387357;8334.083250842403;8355.289800366916;8472.025717042496;8486.957565212258;4094.303968325392;4136.9793151034055;4269.633717210525;4560.156371071363;4571.657125715585;1592.1800272859487;1828.4880233534632;1899.2497963304693;1975.7135215393687;1976.4861136104428;371.9311927293459;372.18491503607015;412.0975064608498;412.9834806607702;415.83782324893315;11712.355820429959;11960.700982475508;12149.878501215051;12158.33129177886;12184.20802647825;423.69070578477886;424.9362595610683;430.87719999799907;451.09105153116496;463.677743967939;5928.110783382527;6122.326544080148;6206.937930620727;6300.27546832111;10813.118725859134;514992;609384;611676;619193.9040304769;621380;72917.63541182366;83579;85208.14791852127;123223;130518.34740826425;992.0674565908023;997.3766396002499;1012.8936461671714;1016.3444578246989;1025.2259544044198;18624.720629190302;19113.90443047776;19178.90410547938;19208.94350810663;19260.133294001524;36945;44417.55582444134;53495;54428.639284018216;55003.449965499836;74578;77621.61189194018;77799;78184.82722759049;78793.60603196947;6957.965210173917;7388.039554857834;7534.472586918863;7574.469787114849;7610.9238907612435;12174.391280435766;12219.816702749287;12885.162464439782;13189.604311870658;13421.32893355348;11090.778184436105;11132.666020019413;11184.105271578092;11195.440227988405;11444.198906076828;10291.382517049002;10899;11104.777904441704;11156.888431115585;11449.255798373079;11520.88479115198;11572.59495917639;11706.590269340531;11743.29540227555;12020.33888136161;8019;8229.135940726137;8509.74470765878;8510.957445212734;8571.471236790665;8602.526861022703;11224.158188136085;11250.66248012561;11350.489227984926;11744.29534227949 14:10:54 INFO - PROCESS | 1643 | |3;mootools.html;1310.5413105413106;1454.0693955868246;1622.0186786993877;1629.1039928039584;1833.5324492254474;7473.215312392202;7552.848943021137;7822.061352637677;8211.91788082119;8229.711960081391;7181.605011724353;8048.95975520123;8352.832943341129;8413.200745929142;8667.73996780096;2296.3684986628646;2339.263132113387;2343.8359314847967;2345.1791872844537;2347.084636991566;2332.8716920569364;2369.5971684813535;2378.6432035194684;2388.773066558674;2389.5220955808823;1937.3413039566544;2337.4390146364835;2356.257778799681;2363.9645405318934;2364.1725396111397;1745.589786400195;2311.9653205201935;2334.8015418689433;2340.648902664597;2390.53384590005;1945.785963544009;2342.121704360865;2359.1507057459303;2368.064614477289;2372.2290255666976;8246.917530824676;8316.37627177964;8384.958075209584;8390.538520381377;8426.957865210634;4213.4522512073545;4440.178566965122;5067.239914012891;5223.11207094791;5226.05930932432;2734.7128551502005;3312.420326442863;3593.94609080864;3608.8376023078763;3617.782933024027;1041.250299784154;1061.241212533035;1063.643679367413;1079.7570546627026;1112.0269763956537;10950.671479855617;10974;11020.063294619968;11047.83428248577;11094.944525277322;4529.230030894756;4539.863804085882;4642.3500709900645;4649.907001859944;4782.0914026334885;9483.762905927408;9570.99504552012;9592.424454532751;9614.567344469515;9640.132388085107;5190.2993095932325;5259.342582177228;5261.76322065508;5269.077911365495;5272.367315922037;3995.820188091485;4285.207236661227;4308.159908817751;4513.81944722214;4818;3791.3175628386603;3825.713071519647;3880.825362858678;3909.902252443712;3934.9606503935165;1270.8538518070354;1280.9359532023361;1280.9551665691656;1287.073307218801;1297.5847728726906;746.268656716421;767.2059418501935;893.9731808045769;905.9728208153766;906.5784410249134;5667.234923285386;5681.971590142023;5867.3839246879315;5922.466977972003;6001.369856165127;909.5906841921029;931.3201363005044;932.00275704995;935.9578818953163;959.6449313753956;3510.8420121094614;3605.3330133925306;3633.291508155937;3640.4539319102346;3685.9262814743556;9893.159081478156;10189.23580731448;10232.59069637221;10236.48817559134;10268.229882758673;9946.20430365569;10106.242031847642;10138.442385668859;10145.94927025375;10152.441615711059;7450.478466507292;7784.3772498200005;7791.844163116706;7816.179301173409;7921.722739703968;5729.512991395778;5766.8846623066465;5879.147523609138;5888.293404791452;5921.111833224878;7808.375329973474;9214.631414743335;9333.85999210026;9373.531323433665;9462.905370946202;9447.244220462484;9448.291378146803;9479.905200947902;9574.281928855224;9589.952050239704;6546.636758006653;7023.859522809413;7156.427485801228;7157.606331651601;7327.194008658937;7941.285284324438;7994.1606131355375;8012.5192488450875;8022.59887005659;8031.759047228593;6044.425779550936;7076.469264805057;7117.8576428470105;7230.13238411394;7302.0142280791415;7052.576845389293;7058.682359293742;7148.070750802362;7173.390261827803;7222.241664625139;5172.5603323717905;5317.760700768397;6808.82977925536;6833.180018397824;6833.726650934106;4963.553280204799;5012.248162775612;5051.4695956924;5105.361829771278;5127.2052831811125;4254.978725106354;4312.805923733376;5024.120778863611;5199.246109314053;5204.505571970657 14:10:54 INFO - PROCESS | 1643 | |4;prototype.html;270.6373459564184;288.5757935834323;305.70804881338324;306.3673514193191;310.5295477351811;5232.7122008289525;5340.679559226449;5364.812231571891;5438.102713052346;5469.589780766443;5047.4605245400135;5185.974070129653;5315.415304316532;5322.8137015204475;5362.6514276572;3414.5219669246326;4105.322621767405;4130.2359063573185;4164.354525048622;4176.642591157871;3435.312937412515;3445.7415693822936;4017.337139372;4166;4201.663866890657;3917.4907262055895;4087.0395457067566;4087.5299340575766;4126.66986641068;4143.502779666444;3642.7614611032377;4043.0498832774274;4101.282275601773;4127.2570937231285;4138.234426631083;3598.7660802048044;3616.819159042064;3625.546806649169;3627.72792040598;3631.365885351602;3949.111449923773;4969.652124351297;5231.163013917755;5250.527452529291;5264.657797243205;4192.233126136735;4263.381809637585;4416.271315233015;4469.9776501117285;4725.157188696411;4743.691660042121;5625.46558076982;5667.744951477193;5673.8652269546255;5680.0627896397045;3218.6760007286016;3677.6506231907924;3908.218356328746;3952.940705889414;3966.4218258132155;4840.249761287007;5425.701586412746;5841.101641966378;5853.531717462635;5931.635723783554;4021.678265738734;4024.4566983456857;4029.15387768566;4031.7984100794843;4039.818208180639;3254.3491301739746;3402.659734026627;3573.6247693992277;3943.191645712622;4084.4281800547947;4620.221214832314;4687.554682305175;4714.858554243378;4726.409198850144;4740.217864052462;4363.3018717005125;4542.977285113553;4838.346823178897;5704.771809127671;5712.485876271156;1140.8288756686563;1213.8604060532975;1242.3415589737274;1281.7244292477162;1334.786434170528;916.4363916191494;922.3589605224439;924.4638109896244;926.8980412154658;933.7572231219932;4460.576245256695;4770.76146192689;5184.7926082956255;5193.558547523503;5248.895022099613;4930.235813448921;4930.704157750546;5203.271541984125;5463.344398672105;5556.749946252347;4590.449146102423;5013.849584512471;5067.847964561069;5164.244156986642;5187.870303242449;2549.528337257613;2609.0476975903657;2731.6858561265312;2870.985645071761;2920.7225313595172;4912.484189160086;4921.557059864629;5350.528604633679;5404.432534583812;5783.248177736868;4785.904281914342;5154.381474223117;5487.862803429946;5609.411011843697;5644.322681278273;5162.6902385856965;5229.901720638709;5409.917181885003;5582.469665381782;5660.85847853807;4081.9183616326914;4963.528464795839;5284.180951952453;5621.578381621476;5799.20152300244;4777.9044419112115;5815.121514850176;5862.746175872432;5869.7945571904775;5927.199828023162;5202.0116177926075;5384.9192262116885;6247.9062814056915;6255.96872015637;6309.558330916791;3519.6097541470463;3702.777833330009;3956.643902048714;3981.1639555693628;3988.202359528048;5095.847124586268;5411.431799660979;5625.8593535161945;5901.734421950937;5908.911366329423;4680.789364478538;5306.895466152344;5760.94239057604;5771.441710738161;5828.0966450200285;4596.9310460343795;4830.975845120752;5514.338279406497;5701.857453563694;5747.137929310469;4691.929621055755;5356.946430535645;5376.596755243294;5533.754905146471;5599.440055994368;4647.465541462775;4839.467658557626;5713;5727.8496826744295;5739.483446489836;4661.836835710869;5272.2882410874045;5367.758450869642;5568.526675232651;5588.004576727659 14:10:54 INFO - PROCESS | 1643 | |5;yui.html;671.0940230688572;673.8214373191105;753.7525395470499;765.5712800831539;807.1041144329795;13041.60875173744;13909.721805563895;14758.33587488563;14763.778543321845;14829.555113346603;9853;11307.095432365411;11513;14750.114993100422;14835.184064876428;815.8042069903211;831.846108469932;834.7412302186311;835.4152093534519;835.807764214231;775.5385545600359;816.5304949653972;820.2084987986592;821.4332110843499;822.3421262989614;760.3650951455542;853.4068822168596;878.8945326560822;880.1154839386408;880.5993273060742;815.5188438821094;870.1037930931151;873.5806812729893;875.4659657608853;876.3427429427929;515.8632962265003;645.3062957320852;647.3882181338637;651.9674016299214;654.0614218596329;13826.23955682437;13921.30393480322;13940.860591394057;13946.442142314296;13985.230812305319;13377.732445351136;13592.25242611656;13603.115797473132;13764.65588360289;13785.862141378559;11050;11121.833172502418;11153.386563738992;11234.775304493864;11274.718132046683;3635.4910312556262;3676.7977761223124;3684.1158122050783;3686.262747450494;3726.06848287928;61089.38910610926;86163.56918215432;86951.69572456418;88477.55761221217;88553.55723221342;10306.33008854422;10517.421541815274;10602.893971060344;10661;10674.733131671615;20469.07889144992;20559.280425185047;20669.276575319793;20687.27594534184;20811.479713007295;7258.564486130849;7545.132309784335;7581.924180758232;7631.3894888408795;7695.152793466454;4108.342665173558;4151.211269858717;4242.978785106055;4252.893677658021;4353.760543170156;3101.085179871898;3203.759718021158;3214.164317277525;3230.7415406767404;3233.4503134467195;630.7760744935573;636.7293900092442;639.523554951564;641.8042497038448;648.6173157836898;547.4170008940465;641.8234985378965;646.7542333913177;651.5504302031583;676.462212541031;8835.514046727492;8905.198532132139;9011.684591039282;9152.542372881462;9316.301277404222;558.3634656491603;643.6169684448824;648.9383508566679;651.1112331667334;657.1260223902199;4361.956380436219;4440.822367105344;4479.55204479556;4497.910041799211;4502.347159661831;110674;110992.33511497334;117565.41217293858;119335;119823;99334.5033274829;102072.97927020783;104585.95414045914;106148.46925765321;106699.46650266698;62422;63945.36054639487;88462.99999999872;91774;91861;8702.173293537104;8755.868661969947;8834.072422395557;8931.285497160341;8940.132683238708;57928;58039.70980145072;58170.709146454;59346.70326648339;60357.698211508665;74227.62886185535;78502;79708.60145699234;84351;84383;11373.772524549297;11515.193936424705;11635.858318254193;11793.05655547537;11963.282203067496;12186.086043546593;12239;12253.75492490163;12277.815832762695;12331.260124392566;11695.76608467843;11713.531458741554;11771.88228117742;11784.882151178379;12034.939825300817;9421.81156376855;9463.905360946303;11838.940805296263;11865.228760130563;11952.796346813078;11429.59996400122;11509;11592.304461732323;11802.409879506162;12204.267743935392;9952.800943980936;9975.650852220137;10029.448380339152;10075.294729368874;10307.793844122925;9904.207663387057;10173.796524069625;10182.745431364276;10190.490475476048;10208.948955255177 14:10:54 INFO - PROCESS | 1643 | __end_tp_report 14:10:54 INFO - PROCESS | 1643 | __start_cc_report 14:10:54 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,371 14:10:54 INFO - PROCESS | 1643 | __end_cc_report 14:10:54 INFO - PROCESS | 1643 | __startTimestamp1482358254284__endTimestamp 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:10:54 INFO - PROCESS | 1643 | Number of tests: 6 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5554.41 Median:5741.43 stddev:677.01 (11.8%) stddev-sans-first:656.22 14:10:54 INFO - PROCESS | 1643 | Values: 3330.1 3353.3 3372.8 3373.5 3382.3 5468.5 5518.3 5532.4 5536.9 5548.5 5530.3 5568.1 5600.0 5604.4 5670.8 4217.3 4260.2 4751.0 5101.0 5155.4 4309.2 4659.9 4779.0 5203.3 5222.2 4222.3 5024.2 5031.8 5155.7 5190.2 5079.1 5106.9 5126.3 5137.2 5148.5 4122.7 5083.1 5098.9 5136.1 5143.8 5552.2 5560.0 5647.2 5648.6 5718.5 5876.5 5930.9 5989.4 6000.0 6107.7 6176.5 6179.4 6196.7 6200.6 6204.1 5646.2 5649.7 5653.9 5658.9 5664.1 6118.8 6146.1 6175.2 6235.6 6312.1 5982.4 5986.3 6006.3 6012.7 6047.5 6121.3 6146.5 6155.0 6159.0 6169.0 5746.1 5887.1 5892.9 6001.5 6064.6 5944.9 5960.9 5975.4 5993.0 6005.8 4564.6 4759.9 4785.4 4797.6 4805.9 3704.6 4156.9 4292.1 4357.1 4362.5 5653.2 5753.8 5794.7 5800.8 5868.4 5999.7 6192.6 6195.0 6213.8 6217.2 5663.5 5741.4 5751.9 5771.7 5776.2 5293.4 5313.6 5323.1 5341.3 5355.9 5510.0 6316.1 6324.9 6338.4 6344.4 6010.1 6034.8 6058.8 6115.0 6210.6 6226.2 6260.8 6266.1 6304.7 6311.9 5994.5 6007.5 6011.3 6040.2 6076.1 6056.1 6056.2 6142.3 6149.4 6183.4 5646.4 5714.9 5754.5 5793.9 5921.0 5620.6 5688.7 5729.2 5747.9 5767.6 4604.9 5024.3 5458.8 5603.4 5621.2 4757.7 5694.9 5706.1 5759.2 5795.5 5715.7 5745.3 5751.6 5754.6 5779.7 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68760.56 Median:39096.21 stddev:154252.87 (394.5%) stddev-sans-first:154600.26 14:10:54 INFO - PROCESS | 1643 | Values: 425.2 497.7 513.8 526.9 552.9 37586.4 39147.8 39324.8 39328.8 39406.2 33233.8 40606.8 40682.8 40689.4 40766.4 9387.6 9543.3 9545.2 9548.0 9578.8 9329.7 9428.6 9432.7 9434.4 9440.9 9314.1 9413.2 9442.9 9443.2 9493.6 9343.2 9423.9 9432.8 9443.2 9481.1 9291.3 9376.3 9452.6 9455.1 9457.8 38738.0 39009.0 39038.4 39046.8 39145.6 3322.4 3326.3 3348.4 3873.1 3880.1 28590.1 28681.6 29613.8 29987.0 30111.8 3168.9 3244.9 3248.5 3249.8 3307.9 415351.0 421635.9 422749.0 423373.0 423375.0 55420.9 55919.0 55929.2 55984.6 56054.4 57428.0 57873.8 58227.4 58546.0 58695.4 15403.5 15606.7 15646.8 15655.6 15672.3 11764.3 11851.5 11942.3 11947.9 12012.4 14692.0 14914.3 15296.3 15322.9 15338.5 3222.3 5862.4 6789.0 6864.1 6866.8 823.6 843.6 879.6 962.8 964.7 23217.4 29179.3 29268.0 29364.6 29795.8 891.5 979.1 1021.9 1044.1 1055.7 11771.6 11927.5 15221.9 15454.8 15464.6 660533.0 665133.0 665730.0 667632.0 672278.0 55383.2 55520.0 55710.7 55897.4 56160.4 1118.4 1205.9 1223.8 1364.9 1392.7 25128.9 26830.0 28212.7 28500.3 29399.7 47787.0 47819.3 47907.8 48237.8 48371.5 606601.0 609304.0 610096.0 611787.0 611842.0 21635.6 26137.5 26178.6 26190.3 26204.6 37268.8 44393.7 44554.8 44961.6 45006.3 36403.3 36569.3 37101.4 38159.6 38392.2 36840.1 37138.8 37530.1 37739.0 38124.6 30748.7 36555.0 36620.5 36671.0 37170.3 32034.7 33538.0 33849.7 33905.5 33988.0 25098.6 25140.7 25174.6 25551.7 25692.2 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:33560.77 Median:367.34 stddev:99155.62 (26992.9%) stddev-sans-first:99402.45 14:10:54 INFO - PROCESS | 1643 | Values: 366.4 368.2 376.1 379.9 388.5 18541.6 19098.8 19795.5 19818.9 19985.1 18542.8 19163.1 19189.9 19785.6 19798.4 5312.0 5387.5 5492.6 5504.6 5989.3 3844.8 5995.5 6013.7 6056.6 6062.2 4034.2 5807.8 6063.9 6108.9 6136.3 6002.9 6076.8 6079.2 6111.7 6144.8 5933.5 5950.1 5985.3 5994.1 6008.2 13037.7 23407.6 23517.4 24107.4 24160.5 2160.8 2165.0 2179.2 2550.8 2717.0 10222.4 10375.4 12108.7 14453.3 15106.6 1604.4 1811.3 1875.2 1880.5 1884.4 116880.0 118663.0 118952.0 121139.4 121570.0 10022.8 10285.4 11348.3 11469.9 11550.0 14590.3 14663.1 14667.5 14689.5 14709.7 8224.5 8437.9 8513.1 8609.9 8653.9 7758.1 8334.1 8355.3 8472.0 8487.0 4094.3 4137.0 4269.6 4560.2 4571.7 1592.2 1828.5 1899.2 1975.7 1976.5 371.9 372.2 412.1 413.0 415.8 11712.4 11960.7 12149.9 12158.3 12184.2 423.7 424.9 430.9 451.1 463.7 5928.1 6122.3 6206.9 6300.3 10813.1 514992.0 609384.0 611676.0 619193.9 621380.0 72917.6 83579.0 85208.1 123223.0 130518.3 992.1 997.4 1012.9 1016.3 1025.2 18624.7 19113.9 19178.9 19208.9 19260.1 36945.0 44417.6 53495.0 54428.6 55003.4 74578.0 77621.6 77799.0 78184.8 78793.6 6958.0 7388.0 7534.5 7574.5 7610.9 12174.4 12219.8 12885.2 13189.6 13421.3 11090.8 11132.7 11184.1 11195.4 11444.2 10291.4 10899.0 11104.8 11156.9 11449.3 11520.9 11572.6 11706.6 11743.3 12020.3 8019.0 8229.1 8509.7 8511.0 8571.5 8602.5 11224.2 11250.7 11350.5 11744.3 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5429.95 Median:5194.77 stddev:2995.82 (57.7%) stddev-sans-first:2988.23 14:10:54 INFO - PROCESS | 1643 | Values: 1310.5 1454.1 1622.0 1629.1 1833.5 7473.2 7552.8 7822.1 8211.9 8229.7 7181.6 8049.0 8352.8 8413.2 8667.7 2296.4 2339.3 2343.8 2345.2 2347.1 2332.9 2369.6 2378.6 2388.8 2389.5 1937.3 2337.4 2356.3 2364.0 2364.2 1745.6 2312.0 2334.8 2340.6 2390.5 1945.8 2342.1 2359.2 2368.1 2372.2 8246.9 8316.4 8385.0 8390.5 8427.0 4213.5 4440.2 5067.2 5223.1 5226.1 2734.7 3312.4 3593.9 3608.8 3617.8 1041.3 1061.2 1063.6 1079.8 1112.0 10950.7 10974.0 11020.1 11047.8 11094.9 4529.2 4539.9 4642.4 4649.9 4782.1 9483.8 9571.0 9592.4 9614.6 9640.1 5190.3 5259.3 5261.8 5269.1 5272.4 3995.8 4285.2 4308.2 4513.8 4818.0 3791.3 3825.7 3880.8 3909.9 3935.0 1270.9 1280.9 1281.0 1287.1 1297.6 746.3 767.2 894.0 906.0 906.6 5667.2 5682.0 5867.4 5922.5 6001.4 909.6 931.3 932.0 936.0 959.6 3510.8 3605.3 3633.3 3640.5 3685.9 9893.2 10189.2 10232.6 10236.5 10268.2 9946.2 10106.2 10138.4 10145.9 10152.4 7450.5 7784.4 7791.8 7816.2 7921.7 5729.5 5766.9 5879.1 5888.3 5921.1 7808.4 9214.6 9333.9 9373.5 9462.9 9447.2 9448.3 9479.9 9574.3 9590.0 6546.6 7023.9 7156.4 7157.6 7327.2 7941.3 7994.2 8012.5 8022.6 8031.8 6044.4 7076.5 7117.9 7230.1 7302.0 7052.6 7058.7 7148.1 7173.4 7222.2 5172.6 5317.8 6808.8 6833.2 6833.7 4963.6 5012.2 5051.5 5105.4 5127.2 4255.0 4312.8 5024.1 5199.2 5204.5 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4470.20 Median:4925.90 stddev:1368.45 (27.8%) stddev-sans-first:1335.49 14:10:54 INFO - PROCESS | 1643 | Values: 270.6 288.6 305.7 306.4 310.5 5232.7 5340.7 5364.8 5438.1 5469.6 5047.5 5186.0 5315.4 5322.8 5362.7 3414.5 4105.3 4130.2 4164.4 4176.6 3435.3 3445.7 4017.3 4166.0 4201.7 3917.5 4087.0 4087.5 4126.7 4143.5 3642.8 4043.0 4101.3 4127.3 4138.2 3598.8 3616.8 3625.5 3627.7 3631.4 3949.1 4969.7 5231.2 5250.5 5264.7 4192.2 4263.4 4416.3 4470.0 4725.2 4743.7 5625.5 5667.7 5673.9 5680.1 3218.7 3677.7 3908.2 3952.9 3966.4 4840.2 5425.7 5841.1 5853.5 5931.6 4021.7 4024.5 4029.2 4031.8 4039.8 3254.3 3402.7 3573.6 3943.2 4084.4 4620.2 4687.6 4714.9 4726.4 4740.2 4363.3 4543.0 4838.3 5704.8 5712.5 1140.8 1213.9 1242.3 1281.7 1334.8 916.4 922.4 924.5 926.9 933.8 4460.6 4770.8 5184.8 5193.6 5248.9 4930.2 4930.7 5203.3 5463.3 5556.7 4590.4 5013.8 5067.8 5164.2 5187.9 2549.5 2609.0 2731.7 2871.0 2920.7 4912.5 4921.6 5350.5 5404.4 5783.2 4785.9 5154.4 5487.9 5609.4 5644.3 5162.7 5229.9 5409.9 5582.5 5660.9 4081.9 4963.5 5284.2 5621.6 5799.2 4777.9 5815.1 5862.7 5869.8 5927.2 5202.0 5384.9 6247.9 6256.0 6309.6 3519.6 3702.8 3956.6 3981.2 3988.2 5095.8 5411.4 5625.9 5901.7 5908.9 4680.8 5306.9 5760.9 5771.4 5828.1 4596.9 4831.0 5514.3 5701.9 5747.1 4691.9 5356.9 5376.6 5533.8 5599.4 4647.5 4839.5 5713.0 5727.8 5739.5 4661.8 5272.3 5367.8 5568.5 5588.0 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20642.55 Median:4488.73 stddev:31144.92 (693.8%) stddev-sans-first:31196.19 14:10:54 INFO - PROCESS | 1643 | Values: 671.1 673.8 753.8 765.6 807.1 13041.6 13909.7 14758.3 14763.8 14829.6 9853.0 11307.1 11513.0 14750.1 14835.2 815.8 831.8 834.7 835.4 835.8 775.5 816.5 820.2 821.4 822.3 760.4 853.4 878.9 880.1 880.6 815.5 870.1 873.6 875.5 876.3 515.9 645.3 647.4 652.0 654.1 13826.2 13921.3 13940.9 13946.4 13985.2 13377.7 13592.3 13603.1 13764.7 13785.9 11050.0 11121.8 11153.4 11234.8 11274.7 3635.5 3676.8 3684.1 3686.3 3726.1 61089.4 86163.6 86951.7 88477.6 88553.6 10306.3 10517.4 10602.9 10661.0 10674.7 20469.1 20559.3 20669.3 20687.3 20811.5 7258.6 7545.1 7581.9 7631.4 7695.2 4108.3 4151.2 4243.0 4252.9 4353.8 3101.1 3203.8 3214.2 3230.7 3233.5 630.8 636.7 639.5 641.8 648.6 547.4 641.8 646.8 651.6 676.5 8835.5 8905.2 9011.7 9152.5 9316.3 558.4 643.6 648.9 651.1 657.1 4362.0 4440.8 4479.6 4497.9 4502.3 110674.0 110992.3 117565.4 119335.0 119823.0 99334.5 102073.0 104586.0 106148.5 106699.5 62422.0 63945.4 88463.0 91774.0 91861.0 8702.2 8755.9 8834.1 8931.3 8940.1 57928.0 58039.7 58170.7 59346.7 60357.7 74227.6 78502.0 79708.6 84351.0 84383.0 11373.8 11515.2 11635.9 11793.1 11963.3 12186.1 12239.0 12253.8 12277.8 12331.3 11695.8 11713.5 11771.9 11784.9 12034.9 9421.8 9463.9 11838.9 11865.2 11952.8 11429.6 11509.0 11592.3 11802.4 12204.3 9952.8 9975.7 10029.4 10075.3 10307.8 9904.2 10173.8 10182.7 10190.5 10208.9 14:10:54 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:10:54 INFO - PROCESS | 1643 | 14:10:54 INFO - TEST-INFO | 1643: exit 0 14:10:54 INFO - TEST-OK | dromaeo_css | took 1116446ms 14:10:54 INFO - TEST-START | kraken 14:10:54 INFO - operating with platform_type : mac_ 14:10:54 INFO - Initialising browser for kraken test... 14:10:54 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpYZ3KZn/profile http://localhost:49243/getInfo.html) 14:10:58 INFO - PROCESS | 1655 | 2016-12-21 14:10:58.074 plugin-container[1656:10088] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 14:10:58 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:58 INFO - PROCESS | 1655 | 2016-12-21 14:10:58.077 plugin-container[1656:10088] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 14:10:58 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:10:58 INFO - PROCESS | 1655 | 2016-12-21 14:10:58.077 plugin-container[1656:10088] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:10:58 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 14:10:58 INFO - PROCESS | 1655 | colorDepth:24 14:10:58 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 14:10:58 INFO - PROCESS | 1655 | __metrics 14:10:58 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 14:10:59 INFO - TEST-INFO | 1655: exit 0 14:10:59 INFO - Browser initialized. 14:10:59 INFO - Running cycle 1/1 for kraken test... 14:10:59 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/T/tmpYZ3KZn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:01 INFO - PROCESS | 1657 | 2016-12-21 14:11:01.515 plugin-container[1658:10210] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 14:11:01 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:01 INFO - PROCESS | 1657 | 2016-12-21 14:11:01.516 plugin-container[1658:10210] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 14:11:01 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:11:01 INFO - PROCESS | 1657 | 2016-12-21 14:11:01.516 plugin-container[1658:10210] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:11:11 INFO - PROCESS | 1657 | RSS: Main: 229388288 14:11:11 INFO - PROCESS | 1657 | 14:11:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:15 INFO - PROCESS | 1657 | RSS: Main: 241639424 14:11:15 INFO - PROCESS | 1657 | 14:11:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 14:11:18 INFO - PROCESS | 1657 | RSS: Main: 249159680 14:11:18 INFO - PROCESS | 1657 | 14:11:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 14:11:22 INFO - PROCESS | 1657 | RSS: Main: 252850176 14:11:22 INFO - PROCESS | 1657 | 14:11:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 14:11:24 INFO - PROCESS | 1657 | RSS: Main: 253435904 14:11:24 INFO - PROCESS | 1657 | 14:11:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:27 INFO - PROCESS | 1657 | RSS: Main: 253222912 14:11:27 INFO - PROCESS | 1657 | 14:11:30 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:30 INFO - PROCESS | 1657 | RSS: Main: 258707456 14:11:30 INFO - PROCESS | 1657 | 14:11:33 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:34 INFO - PROCESS | 1657 | RSS: Main: 259346432 14:11:34 INFO - PROCESS | 1657 | 14:11:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 14:11:38 INFO - PROCESS | 1657 | RSS: Main: 258793472 14:11:38 INFO - PROCESS | 1657 | 14:11:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:40 INFO - PROCESS | 1657 | RSS: Main: 257085440 14:11:40 INFO - PROCESS | 1657 | 14:11:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:43 INFO - PROCESS | 1657 | RSS: Main: 257171456 14:11:43 INFO - PROCESS | 1657 | 14:11:45 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:45 INFO - PROCESS | 1657 | RSS: Main: 257155072 14:11:45 INFO - PROCESS | 1657 | 14:11:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:49 INFO - PROCESS | 1657 | RSS: Main: 257417216 14:11:49 INFO - PROCESS | 1657 | 14:11:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:53 INFO - PROCESS | 1657 | RSS: Main: 257540096 14:11:53 INFO - PROCESS | 1657 | 14:11:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 14:11:55 INFO - PROCESS | 1657 | RSS: Main: 259465216 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | __start_tp_report 14:11:55 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:11:55 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:11:55 INFO - PROCESS | 1657 | |i|pagename|runs| 14:11:55 INFO - PROCESS | 1657 | |0;ai-astar;105;117;118;119;119;99;163;172;161;109 14:11:55 INFO - PROCESS | 1657 | |1;audio-beat-detection;146;111;111;148;111;118;111;110;137;114 14:11:55 INFO - PROCESS | 1657 | |2;audio-dft;199;201;193;198;187;194;200;196;205;193 14:11:55 INFO - PROCESS | 1657 | |3;audio-fft;84;57;59;86;60;59;59;59;78;59 14:11:55 INFO - PROCESS | 1657 | |4;audio-oscillator;92;103;110;72;69;69;88;68;73;84 14:11:55 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;88;86;89;87;89;86;91;100;119;131 14:11:55 INFO - PROCESS | 1657 | |6;imaging-darkroom;153;118;152;108;96;95;95;95;121;152 14:11:55 INFO - PROCESS | 1657 | |7;imaging-desaturate;88;89;87;123;140;137;90;90;88;89 14:11:55 INFO - PROCESS | 1657 | |8;json-parse-financial;56;58;57;59;62;61;59;60;60;59 14:11:55 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;75;97;88;77;79;70;70;86;63;71 14:11:55 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;85;83;84;84;85;110;77;98;107;103 14:11:55 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;161;150;130;151;164;149;145;189;209;130 14:11:55 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;165;210;220;167;164;168;166;170;166;170 14:11:55 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;73;83;88;74;67;69;69;79;89 14:11:55 INFO - PROCESS | 1657 | __end_tp_report 14:11:55 INFO - PROCESS | 1657 | __start_cc_report 14:11:55 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,970 14:11:55 INFO - PROCESS | 1657 | __end_cc_report 14:11:55 INFO - PROCESS | 1657 | __startTimestamp1482358315216__endTimestamp 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:11:55 INFO - PROCESS | 1657 | Number of tests: 14 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:128.20 Median:140.00 stddev:26.59 (19.0%) stddev-sans-first:26.85 14:11:55 INFO - PROCESS | 1657 | Values: 105.0 117.0 118.0 119.0 119.0 99.0 163.0 172.0 161.0 109.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:116.00 stddev:15.58 (13.4%) stddev-sans-first:13.82 14:11:55 INFO - PROCESS | 1657 | Values: 146.0 111.0 111.0 148.0 111.0 118.0 111.0 110.0 137.0 114.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:196.60 Median:198.50 stddev:5.10 (2.6%) stddev-sans-first:5.34 14:11:55 INFO - PROCESS | 1657 | Values: 199.0 201.0 193.0 198.0 187.0 194.0 200.0 196.0 205.0 193.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:66.00 Median:59.50 stddev:11.69 (19.6%) stddev-sans-first:10.43 14:11:55 INFO - PROCESS | 1657 | Values: 84.0 57.0 59.0 86.0 60.0 59.0 59.0 59.0 78.0 59.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:72.50 stddev:15.18 (20.9%) stddev-sans-first:15.73 14:11:55 INFO - PROCESS | 1657 | Values: 92.0 103.0 110.0 72.0 69.0 69.0 88.0 68.0 73.0 84.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:87.50 stddev:15.76 (18.0%) stddev-sans-first:16.40 14:11:55 INFO - PROCESS | 1657 | Values: 88.0 86.0 89.0 87.0 89.0 86.0 91.0 100.0 119.0 131.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:118.50 Median:124.00 stddev:25.20 (20.3%) stddev-sans-first:23.43 14:11:55 INFO - PROCESS | 1657 | Values: 153.0 118.0 152.0 108.0 96.0 95.0 95.0 95.0 121.0 152.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:88.50 stddev:21.99 (24.8%) stddev-sans-first:22.73 14:11:55 INFO - PROCESS | 1657 | Values: 88.0 89.0 87.0 123.0 140.0 137.0 90.0 90.0 88.0 89.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.50 stddev:1.79 (3.0%) stddev-sans-first:1.51 14:11:55 INFO - PROCESS | 1657 | Values: 56.0 58.0 57.0 59.0 62.0 61.0 59.0 60.0 60.0 59.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:77.60 Median:78.00 stddev:10.20 (13.1%) stddev-sans-first:10.78 14:11:55 INFO - PROCESS | 1657 | Values: 75.0 97.0 88.0 77.0 79.0 70.0 70.0 86.0 63.0 71.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:84.00 stddev:11.72 (14.0%) stddev-sans-first:12.19 14:11:55 INFO - PROCESS | 1657 | Values: 85.0 83.0 84.0 84.0 85.0 110.0 77.0 98.0 107.0 103.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:157.80 Median:156.00 stddev:24.81 (15.9%) stddev-sans-first:26.28 14:11:55 INFO - PROCESS | 1657 | Values: 161.0 150.0 130.0 151.0 164.0 149.0 145.0 189.0 209.0 130.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:169.00 stddev:20.47 (12.1%) stddev-sans-first:21.27 14:11:55 INFO - PROCESS | 1657 | Values: 165.0 210.0 220.0 167.0 164.0 168.0 166.0 170.0 166.0 170.0 14:11:55 INFO - PROCESS | 1657 | 14:11:55 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:76.50 stddev:8.35 (10.9%) stddev-sans-first:8.35 14:11:55 INFO - PROCESS | 1657 | Values: 68.0 73.0 83.0 88.0 74.0 67.0 69.0 69.0 79.0 89.0 14:11:55 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:11:55 INFO - PROCESS | 1657 | 14:11:56 INFO - TEST-INFO | 1657: exit 0 14:11:56 INFO - TEST-OK | kraken | took 61293ms 14:11:56 INFO - SUITE-END | took 1177s 14:11:56 INFO - Completed test suite (00:19:37) 14:11:56 INFO - javascript benchmark 14:11:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6985.7369592529085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.117518857503, 3353.329334133174, 3372.8482218300173, 3373.460246360583, 3382.27281134556, 5468.453154684529, 5518.2550355702015, 5532.419095994923, 5536.916946245799, 5548.500634942854, 5530.336359636849, 5568.081266591008, 5600.0, 5604.3835178130375, 5670.8015219467325, 4217.325227963511, 4260.169266992938, 4750.954789946223, 5100.990415654772, 5155.355580552431, 4309.245881970643, 4659.906801863961, 4778.952210477885, 5203.349581302337, 5222.242774797652, 4222.345536441856, 5024.196128619422, 5031.849044528652, 5155.664881782691, 5190.169572868342, 5079.060373830853, 5106.9489305106845, 5126.256692779563, 5137.229415587654, 5148.459411761767, 4122.690798190148, 5083.11045567028, 5098.898022039575, 5136.101182293121, 5143.819966301199, 5552.167174923753, 5559.972200139014, 5647.152927060933, 5648.604597678123, 5718.485336319751, 5876.500497457721, 5930.851728706817, 5989.401059893976, 5999.950008748451, 6107.664078475682, 6176.474999624992, 6179.412955769195, 6196.659183744892, 6200.596961197508, 6204.069389591552, 5646.181303710939, 5649.71751412436, 5653.9151912721345, 5658.943410565842, 5664.0937450007805, 6118.832384214075, 6146.078088286703, 6175.166352542439, 6235.594686345373, 6312.147860038928, 5982.40175982407, 5986.281646202484, 6006.279246490449, 6012.699365031818, 6047.546434017467, 6121.265448146251, 6146.5390095743, 6155.045967874987, 6159.0, 6168.9691551541955, 5746.109353050284, 5887.1463637772285, 5892.941070589325, 6001.459868611846, 6064.605800622945, 5944.851378715567, 5960.940390596039, 5975.40245975399, 5993.0, 6005.819825405245, 4564.566366195206, 4759.881002974953, 4785.401824771903, 4797.64017698674, 4805.8558243252755, 3704.6480584344445, 4156.937645935313, 4292.141571685675, 4357.063231405263, 4362.498312694017, 5653.208550802891, 5753.769849205984, 5794.652320860761, 5800.767969281266, 5868.4424979626865, 5999.670018149044, 6192.59748116371, 6195.039768835838, 6213.844653883689, 6217.160683307786, 5663.546916246691, 5741.425857414309, 5751.913721294184, 5771.7114144293455, 5776.191333213354, 5293.417724050351, 5313.628046036741, 5323.0684630190335, 5341.332333458317, 5355.919661205085, 5509.972450137724, 6316.147320111818, 6324.936750632435, 6338.429541341301, 6344.397282258178, 6010.1285313628405, 6034.788782392595, 6058.848528786815, 6115.027386288435, 6210.596311239936, 6226.221722284715, 6260.843478913063, 6266.122742816101, 6304.747810087545, 6311.90532142009, 5994.490468310242, 6007.519398448201, 6011.338752737282, 6040.214772079602, 6076.118962750288, 6056.0915862619195, 6056.152138700498, 6142.293636231891, 6149.385061493815, 6183.412575805291, 5646.435356464321, 5714.9142762857755, 5754.53963682896, 5793.913091303718, 5921.0, 5620.578456615852, 5688.687122208153, 5729.197912292366, 5747.856303592276, 5767.5674324425, 4604.907901842012, 5024.296598476143, 5458.754356054066, 5603.411641777718, 5621.184928185472, 4757.738324392053, 5694.886102278014, 5706.144078388275, 5759.193712880116, 5795.478406943395, 5715.657060576379, 5745.339285981999, 5751.568632352507, 5754.5684073695475, 5779.7110144493445], "value": 5510.541846987341, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.22608851889555, 497.70884032840786, 513.8304359561345, 526.9461077844311, 552.8666234219849, 37586.43620345697, 39147.80426097869, 39324.820255392384, 39328.803355983255, 39406.21187576251, 33233.83383083081, 40606.7969660152, 40682.7965860171, 40689.38965915514, 40766.388504172384, 9387.624495020207, 9543.33196676233, 9545.236381089531, 9548.045195480467, 9578.808423831519, 9329.72010839676, 9428.575714092882, 9432.669856555021, 9434.43393396395, 9440.905590944105, 9314.115159059878, 9413.246940244799, 9442.858357124649, 9443.150116489514, 9493.572789224501, 9343.205827504671, 9423.905760942405, 9432.811343773155, 9443.244540436748, 9481.146696797321, 9291.256699464027, 9376.343655944087, 9452.57463414148, 9455.14903658674, 9457.763555911088, 38738.0, 39009.0, 39038.414423783666, 39046.804765976274, 39145.60854391448, 3322.368749937504, 3326.3347330533747, 3348.380549598308, 3873.094763104621, 3880.1075752577067, 28590.142295731162, 28681.56977645337, 29613.815447382294, 29986.95045673391, 30111.849440752874, 3168.936621267585, 3244.902652920416, 3248.4640034394533, 3249.78876373035, 3307.933841323184, 415351.0, 421635.891820542, 422749.0, 423373.0, 423375.0, 55420.89158216813, 55919.0, 55929.16106258409, 55984.600384989884, 56054.43945560574, 57428.0, 57873.842523150146, 58227.4177258222, 58546.0, 58695.41304586985, 15403.537893863202, 15606.687866242839, 15646.765298520531, 15655.608609784618, 15672.294746736425, 11764.294142351486, 11851.46668399924, 11942.34317112567, 11947.940260298643, 12012.399380030964, 14691.971561990558, 14914.254287285592, 15296.311665975058, 15322.850786190857, 15338.539843804481, 3222.2910959588853, 5862.443067908542, 6788.978904387599, 6864.141982252218, 6866.828329291708, 823.6458322921202, 843.6372359885186, 879.6393478673713, 962.7544976031207, 964.6623681711345, 23217.419564511023, 29179.270518237216, 29268.0, 29364.559531607043, 29795.808167673484, 891.4562117108559, 979.1481411172183, 1021.9320809753825, 1044.1490185498794, 1055.672741450153, 11771.646850594496, 11927.522899084113, 15221.923890380698, 15454.845451545341, 15464.613384665248, 660533.0, 665133.0, 665730.0, 667632.0, 672278.0, 55383.169252461244, 55520.0, 55710.72144639332, 55897.44102559004, 56160.43839561552, 1118.424011634009, 1205.9336736479577, 1223.806788381339, 1364.8635136486273, 1392.6518370407398, 25128.874355628104, 26830.0, 28212.71787282101, 28500.287492812844, 29399.706002939696, 47787.04425911532, 47819.28271075867, 47907.76046119747, 48237.75881120572, 48371.5162848367, 606601.0, 609304.0, 610096.0, 611787.0, 611842.0, 21635.567288653823, 26137.477250455264, 26178.607320890584, 26190.34524136912, 26204.606930896432, 37268.813655931546, 44393.6788586665, 44554.77722611496, 44961.550384495735, 45006.324905127105, 36403.27193456169, 36569.26861462809, 37101.443478347304, 38159.61840381672, 38392.2321553573, 36840.07899802527, 37138.814305928296, 37530.06174845542, 37739.0, 38124.61875381211, 30748.69251307548, 36555.0, 36620.45069323909, 36671.0, 37170.25659486741, 32034.67965320317, 33538.0, 33849.661503384654, 33905.49141762826, 33988.0, 25098.62352064684, 25140.748592514574, 25174.62238066467, 25551.744482554936, 25692.229233123035], "value": 18990.270391069975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.44300662992237, 368.23591048574207, 376.1180032823029, 379.8689452139012, 388.4833171881398, 18541.629167416642, 19098.809011909878, 19795.50511237218, 19818.900905495488, 19985.101415365552, 18542.814571854276, 19163.137658805354, 19189.904050479727, 19785.604287914233, 19798.40604781859, 5312.043832110228, 5387.488188622095, 5492.5605951523985, 5504.587155963319, 5989.311229208632, 3844.7693138411787, 5995.490383317423, 6013.729382177812, 6056.576039677225, 6062.151298818169, 4034.213328400963, 5807.796727114552, 6063.878722425548, 6108.908366374508, 6136.294326152482, 6002.8799424011495, 6076.756929722806, 6079.240094988127, 6111.694415279218, 6144.784932527385, 5933.525317974551, 5950.107483877409, 5985.311689155759, 5994.100884867261, 6008.218931538872, 13037.739245215043, 23407.648885266735, 23517.41206469852, 24107.39731506709, 24160.516789664285, 2160.7947245011856, 2164.9567008659737, 2179.204590324536, 2550.846949183055, 2716.953972720497, 10222.386656800616, 10375.377477351307, 12108.697282567919, 14453.32934758233, 15106.622334441618, 1604.374294025331, 1811.3026484803313, 1875.22178296007, 1880.5204672808484, 1884.4064119802356, 116880.0, 118663.0, 118952.0, 121139.39430302792, 121570.0, 10022.849657255147, 10285.43430111351, 11348.31910085381, 11469.88530114705, 11550.0, 14590.270486475634, 14663.120212787268, 14667.48663796762, 14689.485867994568, 14709.705805884036, 8224.506529608243, 8437.873431898526, 8513.063563008063, 8609.913900861036, 8653.913460865437, 7758.14660387357, 8334.083250842403, 8355.289800366916, 8472.025717042496, 8486.957565212258, 4094.303968325392, 4136.9793151034055, 4269.633717210525, 4560.156371071363, 4571.657125715585, 1592.1800272859487, 1828.4880233534632, 1899.2497963304693, 1975.7135215393687, 1976.4861136104428, 371.9311927293459, 372.18491503607015, 412.0975064608498, 412.9834806607702, 415.83782324893315, 11712.355820429959, 11960.700982475508, 12149.878501215051, 12158.33129177886, 12184.20802647825, 423.69070578477886, 424.9362595610683, 430.87719999799907, 451.09105153116496, 463.677743967939, 5928.110783382527, 6122.326544080148, 6206.937930620727, 6300.27546832111, 10813.118725859134, 514992.0, 609384.0, 611676.0, 619193.9040304769, 621380.0, 72917.63541182366, 83579.0, 85208.14791852127, 123223.0, 130518.34740826425, 992.0674565908023, 997.3766396002499, 1012.8936461671714, 1016.3444578246989, 1025.2259544044198, 18624.720629190302, 19113.90443047776, 19178.90410547938, 19208.94350810663, 19260.133294001524, 36945.0, 44417.55582444134, 53495.0, 54428.639284018216, 55003.449965499836, 74578.0, 77621.61189194018, 77799.0, 78184.82722759049, 78793.60603196947, 6957.965210173917, 7388.039554857834, 7534.472586918863, 7574.469787114849, 7610.9238907612435, 12174.391280435766, 12219.816702749287, 12885.162464439782, 13189.604311870658, 13421.32893355348, 11090.778184436105, 11132.666020019413, 11184.105271578092, 11195.440227988405, 11444.198906076828, 10291.382517049002, 10899.0, 11104.777904441704, 11156.888431115585, 11449.255798373079, 11520.88479115198, 11572.59495917639, 11706.590269340531, 11743.29540227555, 12020.33888136161, 8019.0, 8229.135940726137, 8509.74470765878, 8510.957445212734, 8571.471236790665, 8602.526861022703, 11224.158188136085, 11250.66248012561, 11350.489227984926, 11744.29534227949], "value": 8768.7397097131, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.5413105413106, 1454.0693955868246, 1622.0186786993877, 1629.1039928039584, 1833.5324492254474, 7473.215312392202, 7552.848943021137, 7822.061352637677, 8211.91788082119, 8229.711960081391, 7181.605011724353, 8048.95975520123, 8352.832943341129, 8413.200745929142, 8667.73996780096, 2296.3684986628646, 2339.263132113387, 2343.8359314847967, 2345.1791872844537, 2347.084636991566, 2332.8716920569364, 2369.5971684813535, 2378.6432035194684, 2388.773066558674, 2389.5220955808823, 1937.3413039566544, 2337.4390146364835, 2356.257778799681, 2363.9645405318934, 2364.1725396111397, 1745.589786400195, 2311.9653205201935, 2334.8015418689433, 2340.648902664597, 2390.53384590005, 1945.785963544009, 2342.121704360865, 2359.1507057459303, 2368.064614477289, 2372.2290255666976, 8246.917530824676, 8316.37627177964, 8384.958075209584, 8390.538520381377, 8426.957865210634, 4213.4522512073545, 4440.178566965122, 5067.239914012891, 5223.11207094791, 5226.05930932432, 2734.7128551502005, 3312.420326442863, 3593.94609080864, 3608.8376023078763, 3617.782933024027, 1041.250299784154, 1061.241212533035, 1063.643679367413, 1079.7570546627026, 1112.0269763956537, 10950.671479855617, 10974.0, 11020.063294619968, 11047.83428248577, 11094.944525277322, 4529.230030894756, 4539.863804085882, 4642.3500709900645, 4649.907001859944, 4782.0914026334885, 9483.762905927408, 9570.99504552012, 9592.424454532751, 9614.567344469515, 9640.132388085107, 5190.2993095932325, 5259.342582177228, 5261.76322065508, 5269.077911365495, 5272.367315922037, 3995.820188091485, 4285.207236661227, 4308.159908817751, 4513.81944722214, 4818.0, 3791.3175628386603, 3825.713071519647, 3880.825362858678, 3909.902252443712, 3934.9606503935165, 1270.8538518070354, 1280.9359532023361, 1280.9551665691656, 1287.073307218801, 1297.5847728726906, 746.268656716421, 767.2059418501935, 893.9731808045769, 905.9728208153766, 906.5784410249134, 5667.234923285386, 5681.971590142023, 5867.3839246879315, 5922.466977972003, 6001.369856165127, 909.5906841921029, 931.3201363005044, 932.00275704995, 935.9578818953163, 959.6449313753956, 3510.8420121094614, 3605.3330133925306, 3633.291508155937, 3640.4539319102346, 3685.9262814743556, 9893.159081478156, 10189.23580731448, 10232.59069637221, 10236.48817559134, 10268.229882758673, 9946.20430365569, 10106.242031847642, 10138.442385668859, 10145.94927025375, 10152.441615711059, 7450.478466507292, 7784.3772498200005, 7791.844163116706, 7816.179301173409, 7921.722739703968, 5729.512991395778, 5766.8846623066465, 5879.147523609138, 5888.293404791452, 5921.111833224878, 7808.375329973474, 9214.631414743335, 9333.85999210026, 9373.531323433665, 9462.905370946202, 9447.244220462484, 9448.291378146803, 9479.905200947902, 9574.281928855224, 9589.952050239704, 6546.636758006653, 7023.859522809413, 7156.427485801228, 7157.606331651601, 7327.194008658937, 7941.285284324438, 7994.1606131355375, 8012.5192488450875, 8022.59887005659, 8031.759047228593, 6044.425779550936, 7076.469264805057, 7117.8576428470105, 7230.13238411394, 7302.0142280791415, 7052.576845389293, 7058.682359293742, 7148.070750802362, 7173.390261827803, 7222.241664625139, 5172.5603323717905, 5317.760700768397, 6808.82977925536, 6833.180018397824, 6833.726650934106, 4963.553280204799, 5012.248162775612, 5051.4695956924, 5105.361829771278, 5127.2052831811125, 4254.978725106354, 4312.805923733376, 5024.120778863611, 5199.246109314053, 5204.505571970657], "value": 4399.450290052849, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.6373459564184, 288.5757935834323, 305.70804881338324, 306.3673514193191, 310.5295477351811, 5232.7122008289525, 5340.679559226449, 5364.812231571891, 5438.102713052346, 5469.589780766443, 5047.4605245400135, 5185.974070129653, 5315.415304316532, 5322.8137015204475, 5362.6514276572, 3414.5219669246326, 4105.322621767405, 4130.2359063573185, 4164.354525048622, 4176.642591157871, 3435.312937412515, 3445.7415693822936, 4017.337139372, 4166.0, 4201.663866890657, 3917.4907262055895, 4087.0395457067566, 4087.5299340575766, 4126.66986641068, 4143.502779666444, 3642.7614611032377, 4043.0498832774274, 4101.282275601773, 4127.2570937231285, 4138.234426631083, 3598.7660802048044, 3616.819159042064, 3625.546806649169, 3627.72792040598, 3631.365885351602, 3949.111449923773, 4969.652124351297, 5231.163013917755, 5250.527452529291, 5264.657797243205, 4192.233126136735, 4263.381809637585, 4416.271315233015, 4469.9776501117285, 4725.157188696411, 4743.691660042121, 5625.46558076982, 5667.744951477193, 5673.8652269546255, 5680.0627896397045, 3218.6760007286016, 3677.6506231907924, 3908.218356328746, 3952.940705889414, 3966.4218258132155, 4840.249761287007, 5425.701586412746, 5841.101641966378, 5853.531717462635, 5931.635723783554, 4021.678265738734, 4024.4566983456857, 4029.15387768566, 4031.7984100794843, 4039.818208180639, 3254.3491301739746, 3402.659734026627, 3573.6247693992277, 3943.191645712622, 4084.4281800547947, 4620.221214832314, 4687.554682305175, 4714.858554243378, 4726.409198850144, 4740.217864052462, 4363.3018717005125, 4542.977285113553, 4838.346823178897, 5704.771809127671, 5712.485876271156, 1140.8288756686563, 1213.8604060532975, 1242.3415589737274, 1281.7244292477162, 1334.786434170528, 916.4363916191494, 922.3589605224439, 924.4638109896244, 926.8980412154658, 933.7572231219932, 4460.576245256695, 4770.76146192689, 5184.7926082956255, 5193.558547523503, 5248.895022099613, 4930.235813448921, 4930.704157750546, 5203.271541984125, 5463.344398672105, 5556.749946252347, 4590.449146102423, 5013.849584512471, 5067.847964561069, 5164.244156986642, 5187.870303242449, 2549.528337257613, 2609.0476975903657, 2731.6858561265312, 2870.985645071761, 2920.7225313595172, 4912.484189160086, 4921.557059864629, 5350.528604633679, 5404.432534583812, 5783.248177736868, 4785.904281914342, 5154.381474223117, 5487.862803429946, 5609.411011843697, 5644.322681278273, 5162.6902385856965, 5229.901720638709, 5409.917181885003, 5582.469665381782, 5660.85847853807, 4081.9183616326914, 4963.528464795839, 5284.180951952453, 5621.578381621476, 5799.20152300244, 4777.9044419112115, 5815.121514850176, 5862.746175872432, 5869.7945571904775, 5927.199828023162, 5202.0116177926075, 5384.9192262116885, 6247.9062814056915, 6255.96872015637, 6309.558330916791, 3519.6097541470463, 3702.777833330009, 3956.643902048714, 3981.1639555693628, 3988.202359528048, 5095.847124586268, 5411.431799660979, 5625.8593535161945, 5901.734421950937, 5908.911366329423, 4680.789364478538, 5306.895466152344, 5760.94239057604, 5771.441710738161, 5828.0966450200285, 4596.9310460343795, 4830.975845120752, 5514.338279406497, 5701.857453563694, 5747.137929310469, 4691.929621055755, 5356.946430535645, 5376.596755243294, 5533.754905146471, 5599.440055994368, 4647.465541462775, 4839.467658557626, 5713.0, 5727.8496826744295, 5739.483446489836, 4661.836835710869, 5272.2882410874045, 5367.758450869642, 5568.526675232651, 5588.004576727659], "value": 4035.9220100461084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.0940230688572, 673.8214373191105, 753.7525395470499, 765.5712800831539, 807.1041144329795, 13041.60875173744, 13909.721805563895, 14758.33587488563, 14763.778543321845, 14829.555113346603, 9853.0, 11307.095432365411, 11513.0, 14750.114993100422, 14835.184064876428, 815.8042069903211, 831.846108469932, 834.7412302186311, 835.4152093534519, 835.807764214231, 775.5385545600359, 816.5304949653972, 820.2084987986592, 821.4332110843499, 822.3421262989614, 760.3650951455542, 853.4068822168596, 878.8945326560822, 880.1154839386408, 880.5993273060742, 815.5188438821094, 870.1037930931151, 873.5806812729893, 875.4659657608853, 876.3427429427929, 515.8632962265003, 645.3062957320852, 647.3882181338637, 651.9674016299214, 654.0614218596329, 13826.23955682437, 13921.30393480322, 13940.860591394057, 13946.442142314296, 13985.230812305319, 13377.732445351136, 13592.25242611656, 13603.115797473132, 13764.65588360289, 13785.862141378559, 11050.0, 11121.833172502418, 11153.386563738992, 11234.775304493864, 11274.718132046683, 3635.4910312556262, 3676.7977761223124, 3684.1158122050783, 3686.262747450494, 3726.06848287928, 61089.38910610926, 86163.56918215432, 86951.69572456418, 88477.55761221217, 88553.55723221342, 10306.33008854422, 10517.421541815274, 10602.893971060344, 10661.0, 10674.733131671615, 20469.07889144992, 20559.280425185047, 20669.276575319793, 20687.27594534184, 20811.479713007295, 7258.564486130849, 7545.132309784335, 7581.924180758232, 7631.3894888408795, 7695.152793466454, 4108.342665173558, 4151.211269858717, 4242.978785106055, 4252.893677658021, 4353.760543170156, 3101.085179871898, 3203.759718021158, 3214.164317277525, 3230.7415406767404, 3233.4503134467195, 630.7760744935573, 636.7293900092442, 639.523554951564, 641.8042497038448, 648.6173157836898, 547.4170008940465, 641.8234985378965, 646.7542333913177, 651.5504302031583, 676.462212541031, 8835.514046727492, 8905.198532132139, 9011.684591039282, 9152.542372881462, 9316.301277404222, 558.3634656491603, 643.6169684448824, 648.9383508566679, 651.1112331667334, 657.1260223902199, 4361.956380436219, 4440.822367105344, 4479.55204479556, 4497.910041799211, 4502.347159661831, 110674.0, 110992.33511497334, 117565.41217293858, 119335.0, 119823.0, 99334.5033274829, 102072.97927020783, 104585.95414045914, 106148.46925765321, 106699.46650266698, 62422.0, 63945.36054639487, 88462.99999999872, 91774.0, 91861.0, 8702.173293537104, 8755.868661969947, 8834.072422395557, 8931.285497160341, 8940.132683238708, 57928.0, 58039.70980145072, 58170.709146454, 59346.70326648339, 60357.698211508665, 74227.62886185535, 78502.0, 79708.60145699234, 84351.0, 84383.0, 11373.772524549297, 11515.193936424705, 11635.858318254193, 11793.05655547537, 11963.282203067496, 12186.086043546593, 12239.0, 12253.75492490163, 12277.815832762695, 12331.260124392566, 11695.76608467843, 11713.531458741554, 11771.88228117742, 11784.882151178379, 12034.939825300817, 9421.81156376855, 9463.905360946303, 11838.940805296263, 11865.228760130563, 11952.796346813078, 11429.59996400122, 11509.0, 11592.304461732323, 11802.409879506162, 12204.267743935392, 9952.800943980936, 9975.650852220137, 10029.448380339152, 10075.294729368874, 10307.793844122925, 9904.207663387057, 10173.796524069625, 10182.745431364276, 10190.490475476048, 10208.948955255177], "value": 7132.21065332026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 118.0, 119.0, 119.0, 99.0, 163.0, 172.0, 161.0, 109.0], "value": 128.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 111.0, 148.0, 111.0, 118.0, 111.0, 110.0, 137.0, 114.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 201.0, 193.0, 198.0, 187.0, 194.0, 200.0, 196.0, 205.0, 193.0], "value": 196.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 59.0, 86.0, 60.0, 59.0, 59.0, 59.0, 78.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 103.0, 110.0, 72.0, 69.0, 69.0, 88.0, 68.0, 73.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 87.0, 89.0, 86.0, 91.0, 100.0, 119.0, 131.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 152.0, 108.0, 96.0, 95.0, 95.0, 95.0, 121.0, 152.0], "value": 118.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 87.0, 123.0, 140.0, 137.0, 90.0, 90.0, 88.0, 89.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 59.0, 62.0, 61.0, 59.0, 60.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 97.0, 88.0, 77.0, 79.0, 70.0, 70.0, 86.0, 63.0, 71.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 85.0, 110.0, 77.0, 98.0, 107.0, 103.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 150.0, 130.0, 151.0, 164.0, 149.0, 145.0, 189.0, 209.0, 130.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 210.0, 220.0, 167.0, 164.0, 168.0, 166.0, 170.0, 166.0, 170.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 83.0, 88.0, 74.0, 67.0, 69.0, 69.0, 79.0, 89.0], "value": 75.9, "unit": "score"}]}]} 14:11:56 INFO - Return code: 0 14:11:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:56 ERROR - # TBPL SUCCESS # 14:11:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:56 INFO - 2016-12-21 14:11:56.525 screenresolution[1662:10599] starting screenresolution argv=screenresolution get 14:11:56 INFO - 2016-12-21 14:11:56.528 screenresolution[1662:10599] Display 0: 1600x1200x32@60 14:11:56 INFO - 2016-12-21 14:11:56.534 screenresolution[1663:10602] starting screenresolution argv=screenresolution list 14:11:56 INFO - Available Modes on Display 0 14:11:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:56 INFO - Intel Iris: 14:11:56 INFO - Chipset Model: Intel Iris 14:11:56 INFO - Type: GPU 14:11:56 INFO - Bus: Built-In 14:11:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:56 INFO - Vendor: Intel (0x8086) 14:11:56 INFO - Device ID: 0x0a2e 14:11:56 INFO - Revision ID: 0x0009 14:11:56 INFO - Displays: 14:11:56 INFO - Display: 14:11:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:56 INFO - Display Serial Number: 1600x1200 60 14:11:56 INFO - Main Display: Yes 14:11:56 INFO - Mirror: Off 14:11:56 INFO - Online: Yes 14:11:56 INFO - Rotation: Supported 14:11:56 INFO - Return code: 0 14:11:56 INFO - Running post-action listener: _resource_record_post_action 14:11:56 INFO - [mozharness: 2016-12-21 22:11:56.779919Z] Finished run-tests step (success) 14:11:56 INFO - Running post-run listener: _resource_record_post_run 14:11:56 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37489152; Write bytes: 655116288; Read time: 245; Write time: 1910 14:11:56 INFO - TinderboxPrint: CPU usage
54.3% 14:11:56 INFO - TinderboxPrint: I/O read bytes / time
37,489,152 / 245 14:11:56 INFO - TinderboxPrint: I/O write bytes / time
655,116,288 / 1,910 14:11:56 INFO - TinderboxPrint: CPU idle
2,211.2 (45.7%) 14:11:56 INFO - TinderboxPrint: CPU system
976.2 (20.2%) 14:11:56 INFO - TinderboxPrint: CPU user
1,650.3 (34.1%) 14:11:56 INFO - TinderboxPrint: Swap in / out
386,727,936 / 0 14:11:56 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345965056; Write bytes: 345007616; Read time: 26807; Write time: 714 14:11:56 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35383808; Write bytes: 302981632; Read time: 225; Write time: 1168 14:11:57 INFO - Running post-run listener: _upload_blobber_files 14:11:57 INFO - Blob upload gear active. 14:11:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:57 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:11:57 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:57 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:58 INFO - (blobuploader) - INFO - Done attempting. 14:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:59 INFO - (blobuploader) - INFO - Done attempting. 14:11:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:02 INFO - (blobuploader) - INFO - Done attempting. 14:12:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:02 INFO - Return code: 0 14:12:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0392191fa1b8748551ba4e7c04f4276c67b5e69d819635ef93bc6ef29c58c6fd409018a269d7cbfacef98648c6c4521f4222bddf09823248c2622597d110a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf350cf423d248173f99f729b3d352d6e6d9af2556a8fe71c76ec84ce2e9741c2ee8cd975b9130bd86eb97e75cb5512e31343577788391a18517bcf42d685dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4b7ced046777b0ba584856d27a43cd364baa04fb4d798d646d2a4ce3215b6495de6918a3f7130064201265472074e81f47c971017a838b87664f11edde50ed4"} 14:12:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:02 INFO - Contents: 14:12:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0392191fa1b8748551ba4e7c04f4276c67b5e69d819635ef93bc6ef29c58c6fd409018a269d7cbfacef98648c6c4521f4222bddf09823248c2622597d110a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf350cf423d248173f99f729b3d352d6e6d9af2556a8fe71c76ec84ce2e9741c2ee8cd975b9130bd86eb97e75cb5512e31343577788391a18517bcf42d685dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4b7ced046777b0ba584856d27a43cd364baa04fb4d798d646d2a4ce3215b6495de6918a3f7130064201265472074e81f47c971017a838b87664f11edde50ed4"} 14:12:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:02 INFO - Copying logs to upload dir... 14:12:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.573204 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-21 14:12:02.346970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 14:12:02.351579) ========= 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.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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/Mozilla-Aurora/sha512/0392191fa1b8748551ba4e7c04f4276c67b5e69d819635ef93bc6ef29c58c6fd409018a269d7cbfacef98648c6c4521f4222bddf09823248c2622597d110a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf350cf423d248173f99f729b3d352d6e6d9af2556a8fe71c76ec84ce2e9741c2ee8cd975b9130bd86eb97e75cb5512e31343577788391a18517bcf42d685dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4b7ced046777b0ba584856d27a43cd364baa04fb4d798d646d2a4ce3215b6495de6918a3f7130064201265472074e81f47c971017a838b87664f11edde50ed4"} build_url:https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/Bqty49OVQCuSz5Q1mZT3rw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0392191fa1b8748551ba4e7c04f4276c67b5e69d819635ef93bc6ef29c58c6fd409018a269d7cbfacef98648c6c4521f4222bddf09823248c2622597d110a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf350cf423d248173f99f729b3d352d6e6d9af2556a8fe71c76ec84ce2e9741c2ee8cd975b9130bd86eb97e75cb5512e31343577788391a18517bcf42d685dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4b7ced046777b0ba584856d27a43cd364baa04fb4d798d646d2a4ce3215b6495de6918a3f7130064201265472074e81f47c971017a838b87664f11edde50ed4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 14:12:02.388389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:12:02.388739) ========= 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.2sI7uccEvF/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.8QVFOINisu/Listeners TMPDIR=/var/folders/fy/0ys7dn115ps74h1p_jqwz2w400000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:12:02.436955) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 14:12:02.440281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 14:12:02.440613) ========= ========= Total master_lag: 0.20 =========