builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0257 starttime: 1480444461.92 results: success (0) buildid: 20161129080327 builduid: 25817b78612346fcb59aab790e7f7ca2 revision: af6fea4fe3c79e74b04f669ac3973cd69dd534a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:21.919759) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:21.920235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:21.920522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:21.947590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:21.948040) ========= 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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-11-29 10:34:21-- 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% 168M=0s 2016-11-29 10:34:22 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134484 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:22.107950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:22.108272) ========= 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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.034155 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:22.165621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 10:34:22.165978) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af6fea4fe3c79e74b04f669ac3973cd69dd534a3 --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 af6fea4fe3c79e74b04f669ac3973cd69dd534a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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-11-29 10:34:22,261 truncating revision to first 12 chars 2016-11-29 10:34:22,261 Setting DEBUG logging. 2016-11-29 10:34:22,261 attempt 1/10 2016-11-29 10:34:22,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af6fea4fe3c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 10:34:22,965 unpacking tar archive at: mozilla-aurora-af6fea4fe3c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.983735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 10:34:23.174345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:23.174862) ========= script_repo_revision: af6fea4fe3c79e74b04f669ac3973cd69dd534a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:23.175422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:23.175836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 10:34:23.197181) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-29 10:34:23.197582) ========= /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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:34:23 INFO - MultiFileLogger online at 20161129 10:34:23 in /builds/slave/test 10:34:23 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 10:34:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:34:23 INFO - {'append_to_log': False, 10:34:23 INFO - 'base_work_dir': '/builds/slave/test', 10:34:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:34:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:34:23 INFO - 'branch': 'Mozilla-Aurora', 10:34:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:34:23 INFO - 'config_files': ('talos/mac_config.py',), 10:34:23 INFO - 'default_actions': ('clobber', 10:34:23 INFO - 'read-buildbot-config', 10:34:23 INFO - 'download-and-extract', 10:34:23 INFO - 'populate-webroot', 10:34:23 INFO - 'create-virtualenv', 10:34:23 INFO - 'install', 10:34:23 INFO - 'run-tests'), 10:34:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:34:23 INFO - 'download_minidump_stackwalk': True, 10:34:23 INFO - 'download_symbols': 'ondemand', 10:34:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:34:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:34:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:34:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:34:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:34:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:34:23 INFO - 'installer_path': 'installer.exe', 10:34:23 INFO - 'log_level': 'info', 10:34:23 INFO - 'log_name': 'talos', 10:34:23 INFO - 'log_to_console': True, 10:34:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:34:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:34:23 INFO - 'opt_config_files': (), 10:34:23 INFO - 'pip_index': False, 10:34:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:23 INFO - 'cmd': ('bash', 10:34:23 INFO - '-c', 10:34:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:23 INFO - 'enabled': True, 10:34:23 INFO - 'halt_on_failure': False, 10:34:23 INFO - 'name': 'check_screen_resolution'},), 10:34:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:34:23 INFO - 'cmd': ('bash', 10:34:23 INFO - '-c', 10:34:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:34:23 INFO - 'enabled': True, 10:34:23 INFO - 'halt_on_failure': False, 10:34:23 INFO - 'name': 'check_screen_resolution'},), 10:34:23 INFO - 'run_cmd_checks_enabled': True, 10:34:23 INFO - 'sps_profile': False, 10:34:23 INFO - 'sps_profile_interval': 0, 10:34:23 INFO - 'suite': 'dromaeojs-e10s', 10:34:23 INFO - 'system_bits': '32', 10:34:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:34:23 INFO - 'title': 't-yosemite-r7-0257', 10:34:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:34:23 INFO - 'use_talos_json': True, 10:34:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:34:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:34:23 INFO - 'work_dir': 'build'} 10:34:23 INFO - [mozharness: 2016-11-29 18:34:23.399679Z] Running clobber step. 10:34:23 INFO - Running pre-action listener: _resource_record_pre_action 10:34:23 INFO - Running main action method: clobber 10:34:23 INFO - rmtree: /builds/slave/test/build 10:34:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:34:25 INFO - Running post-action listener: _resource_record_post_action 10:34:25 INFO - [mozharness: 2016-11-29 18:34:25.782698Z] Finished clobber step (success) 10:34:25 INFO - [mozharness: 2016-11-29 18:34:25.782828Z] Running read-buildbot-config step. 10:34:25 INFO - Running pre-action listener: _resource_record_pre_action 10:34:25 INFO - Running main action method: read_buildbot_config 10:34:25 INFO - Using buildbot properties: 10:34:25 INFO - { 10:34:25 INFO - "project": "", 10:34:25 INFO - "product": "firefox", 10:34:25 INFO - "script_repo_revision": "production", 10:34:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:34:25 INFO - "repository": "", 10:34:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:34:25 INFO - "buildid": "20161129080327", 10:34:25 INFO - "pgo_build": "False", 10:34:25 INFO - "basedir": "/builds/slave/test", 10:34:25 INFO - "buildnumber": 7, 10:34:25 INFO - "slavename": "t-yosemite-r7-0257", 10:34:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:34:25 INFO - "platform": "yosemite_r7", 10:34:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:34:25 INFO - "branch": "mozilla-aurora", 10:34:25 INFO - "repo_path": "releases/mozilla-aurora", 10:34:25 INFO - "revision": "af6fea4fe3c79e74b04f669ac3973cd69dd534a3", 10:34:25 INFO - "stage_platform": "macosx64", 10:34:25 INFO - "builduid": "25817b78612346fcb59aab790e7f7ca2", 10:34:25 INFO - "slavebuilddir": "test" 10:34:25 INFO - } 10:34:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:34:25 INFO - Running post-action listener: _resource_record_post_action 10:34:25 INFO - [mozharness: 2016-11-29 18:34:25.786135Z] Finished read-buildbot-config step (success) 10:34:25 INFO - [mozharness: 2016-11-29 18:34:25.786274Z] Running download-and-extract step. 10:34:25 INFO - Running pre-action listener: _resource_record_pre_action 10:34:25 INFO - Running main action method: download_and_extract 10:34:25 INFO - mkdir: /builds/slave/test/build/tests 10:34:25 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')]} 10:34:25 INFO - trying https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:34:25 INFO - Downloading https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/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 10:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/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 10:34:26 INFO - Downloaded 1199 bytes. 10:34:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:34:26 INFO - Using the following test package requirements: 10:34:26 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:34:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:34:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:34:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'jsshell-mac.zip'], 10:34:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:34:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:34:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:34:26 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:34:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:34:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:34:26 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:34:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:34:27 INFO - Http code: 200 10:34:27 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 10:34:27 INFO - x-amz-cf-id: ArewJYtREZIsQX28i9gtGLqIeiIjBZXVGEupu5PXM8uXDhE7HX82uw== 10:34:27 INFO - x-amz-version-id: qFR0z9xN2ZAdnm5elx9nVytzmU5_fmpX 10:34:27 INFO - Expected file size: 16282907 10:34:27 INFO - Obtained file size: 16282907 10:34:34 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 10:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:34:34 INFO - Http code: 200 10:34:34 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:34:34 INFO - x-amz-cf-id: u82KsMEWs9tSJC0Ro161tuHgWrML6dw8VPi32d-pS3W7D9J7v6JUVg== 10:34:34 INFO - x-amz-version-id: qFR0z9xN2ZAdnm5elx9nVytzmU5_fmpX 10:34:35 INFO - Expected file size: 16282907 10:34:35 INFO - Obtained file size: 16282907 10:34:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:34:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:34:41 INFO - Fetch https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:34:42 INFO - Http code: 200 10:34:42 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 10:34:42 INFO - x-amz-cf-id: SlAfgUuHGZ4W71WsUjHseEPn5TpPYj_UncIc6lt4oPKqmCAMyrKRNA== 10:34:42 INFO - x-amz-version-id: DXdjmidbrNT3016aiHp3McQ8tPLJT_bi 10:34:42 INFO - Expected file size: 14409038 10:34:42 INFO - Obtained file size: 14409038 10:34:42 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')]} 10:34:42 INFO - trying https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:34:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/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 10:34:45 INFO - Downloaded 109834644 bytes. 10:34:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:34:45 INFO - mkdir: /builds/slave/test/properties 10:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:45 INFO - Contents: 10:34:45 INFO - build_url:https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:34:46 INFO - Running post-action listener: _resource_record_post_action 10:34:46 INFO - Running post-action listener: set_extra_try_arguments 10:34:46 INFO - [mozharness: 2016-11-29 18:34:46.186620Z] Finished download-and-extract step (success) 10:34:46 INFO - [mozharness: 2016-11-29 18:34:46.186771Z] Running populate-webroot step. 10:34:46 INFO - Running pre-action listener: _resource_record_pre_action 10:34:46 INFO - Running main action method: populate_webroot 10:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:46 INFO - '--tppagecycles', 10:34:46 INFO - '7'], 10:34:46 INFO - 'tests': ['tsvgm']}}, 10:34:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['damp', 'tps']}, 10:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'tests': ['damp', 'tps']}, 10:34:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['dromaeo_dom']}, 10:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['basic_compositor_video']}, 10:34:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:34:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['a11yr', 10:34:46 INFO - 'ts_paint', 10:34:46 INFO - 'tpaint', 10:34:46 INFO - 'sessionrestore', 10:34:46 INFO - 'sessionrestore_no_auto_restore', 10:34:46 INFO - 'tabpaint']}, 10:34:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['tsvgx', 10:34:46 INFO - 'tsvgr_opacity', 10:34:46 INFO - 'tart', 10:34:46 INFO - 'tscrollx', 10:34:46 INFO - 'cart']}, 10:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:46 INFO - 'tsvgr_opacity', 10:34:46 INFO - 'tart', 10:34:46 INFO - 'tscrollx', 10:34:46 INFO - 'cart']}, 10:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'talos_options': ['--disable-e10s'], 10:34:46 INFO - 'tests': ['tp5o']}, 10:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'tests': ['tp5o']}, 10:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'talos_options': ['--disable-e10s', 10:34:46 INFO - '--xperf_path', 10:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:46 INFO - 'tests': ['tp5n']}, 10:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:46 INFO - 'talos_options': ['--xperf_path', 10:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:46 INFO - 'tests': ['tp5n']}}, 10:34:46 INFO - 'talos.zip': {'path': '', 10:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:46 INFO - Running post-action listener: _resource_record_post_action 10:34:46 INFO - [mozharness: 2016-11-29 18:34:46.205405Z] Finished populate-webroot step (success) 10:34:46 INFO - [mozharness: 2016-11-29 18:34:46.205533Z] Running create-virtualenv step. 10:34:46 INFO - Running pre-action listener: _resource_record_pre_action 10:34:46 INFO - Running main action method: create_virtualenv 10:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:46 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 10:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:46 INFO - Using real prefix '/tools/python27' 10:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:49 INFO - Installing pip.................done. 10:34:49 INFO - Return code: 0 10:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:34:50 INFO - Reading from file tmpfile_stdout 10:34:50 INFO - Output received: 10:34:50 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) 10:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:50 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')]} 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 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')]} 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:34:50 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 10:34:50 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 10:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:50 INFO - 'HOME': '/Users/cltbld', 10:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PAGER': '/bin/cat', 10:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:34:50 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - 'XPC_FLAGS': '0x0', 10:34:50 INFO - 'XPC_SERVICE_NAME': '0', 10:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:50 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 10:34:50 INFO - Cleaning up... 10:34:50 INFO - Return code: 0 10:34:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:50 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')]} 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 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')]} 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:50 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:34:50 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 10:34:50 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 10:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:50 INFO - 'HOME': '/Users/cltbld', 10:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:50 INFO - 'LOGNAME': 'cltbld', 10:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:50 INFO - 'MOZ_NO_REMOTE': '1', 10:34:50 INFO - 'NO_EM_RESTART': '1', 10:34:50 INFO - 'PAGER': '/bin/cat', 10:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:50 INFO - 'PWD': '/builds/slave/test', 10:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:50 INFO - 'SHELL': '/bin/bash', 10:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:34:50 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:50 INFO - 'USER': 'cltbld', 10:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:50 INFO - 'XPC_FLAGS': '0x0', 10:34:50 INFO - 'XPC_SERVICE_NAME': '0', 10:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:50 INFO - Downloading/unpacking psutil>=3.1.1 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:54 INFO - Installing collected packages: psutil 10:34:54 INFO - Running setup.py install for psutil 10:34:54 INFO - building 'psutil._psutil_osx' extension 10:34:54 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 10:34:54 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 10:34:54 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 10:34:54 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 10:34:55 INFO - building 'psutil._psutil_posix' extension 10:34:55 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 10:34:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:34:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:34:55 INFO - ^ 10:34:55 INFO - 1 warning generated. 10:34:55 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 10:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:55 INFO - Successfully installed psutil 10:34:55 INFO - Cleaning up... 10:34:55 INFO - Return code: 0 10:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:55 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:34:55 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 10:34:55 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 10:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:55 INFO - 'HOME': '/Users/cltbld', 10:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:55 INFO - 'LOGNAME': 'cltbld', 10:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:55 INFO - 'MOZ_NO_REMOTE': '1', 10:34:55 INFO - 'NO_EM_RESTART': '1', 10:34:55 INFO - 'PAGER': '/bin/cat', 10:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:55 INFO - 'PWD': '/builds/slave/test', 10:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:55 INFO - 'SHELL': '/bin/bash', 10:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:34:55 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:55 INFO - 'USER': 'cltbld', 10:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:55 INFO - 'XPC_FLAGS': '0x0', 10:34:55 INFO - 'XPC_SERVICE_NAME': '0', 10:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:58 INFO - Installing collected packages: mozsystemmonitor 10:34:58 INFO - Running setup.py install for mozsystemmonitor 10:34:58 INFO - Successfully installed mozsystemmonitor 10:34:58 INFO - Cleaning up... 10:34:58 INFO - Return code: 0 10:34:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:58 INFO - 'HOME': '/Users/cltbld', 10:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:58 INFO - 'LOGNAME': 'cltbld', 10:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:58 INFO - 'MOZ_NO_REMOTE': '1', 10:34:58 INFO - 'NO_EM_RESTART': '1', 10:34:58 INFO - 'PAGER': '/bin/cat', 10:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:58 INFO - 'PWD': '/builds/slave/test', 10:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:58 INFO - 'SHELL': '/bin/bash', 10:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:34:58 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:58 INFO - 'USER': 'cltbld', 10:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:58 INFO - 'XPC_FLAGS': '0x0', 10:34:58 INFO - 'XPC_SERVICE_NAME': '0', 10:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:34:58 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 10:34:58 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 10:34:58 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 10:34:58 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 10:34:58 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 10:34:58 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 10:35:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:01 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 10:35:01 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 10:35:01 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 10:35:01 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 10:35:01 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 10:35:01 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 10:35:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:01 INFO - warning: no files found matching '*.txt' 10:35:01 INFO - no previously-included directories found matching 'build' 10:35:01 INFO - no previously-included directories found matching 'dist' 10:35:01 INFO - no previously-included directories found matching '.git*' 10:35:01 INFO - Installing collected packages: jsonschema, functools32 10:35:01 INFO - Running setup.py install for functools32 10:35:01 INFO - warning: no files found matching '*.txt' 10:35:01 INFO - no previously-included directories found matching 'build' 10:35:01 INFO - no previously-included directories found matching 'dist' 10:35:01 INFO - no previously-included directories found matching '.git*' 10:35:01 INFO - Successfully installed jsonschema functools32 10:35:01 INFO - Cleaning up... 10:35:02 INFO - Return code: 0 10:35:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35:02 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 10:35:02 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 10:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:02 INFO - 'HOME': '/Users/cltbld', 10:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:02 INFO - 'LOGNAME': 'cltbld', 10:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:02 INFO - 'MOZ_NO_REMOTE': '1', 10:35:02 INFO - 'NO_EM_RESTART': '1', 10:35:02 INFO - 'PAGER': '/bin/cat', 10:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:02 INFO - 'PWD': '/builds/slave/test', 10:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:02 INFO - 'SHELL': '/bin/bash', 10:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:02 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:02 INFO - 'USER': 'cltbld', 10:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:02 INFO - 'XPC_FLAGS': '0x0', 10:35:02 INFO - 'XPC_SERVICE_NAME': '0', 10:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:35:02 INFO - Cleaning up... 10:35:02 INFO - Return code: 0 10:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:02 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35:02 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 10:35:02 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 10:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:02 INFO - 'HOME': '/Users/cltbld', 10:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:02 INFO - 'LOGNAME': 'cltbld', 10:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:02 INFO - 'MOZ_NO_REMOTE': '1', 10:35:02 INFO - 'NO_EM_RESTART': '1', 10:35:02 INFO - 'PAGER': '/bin/cat', 10:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:02 INFO - 'PWD': '/builds/slave/test', 10:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:02 INFO - 'SHELL': '/bin/bash', 10:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:02 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:02 INFO - 'USER': 'cltbld', 10:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:02 INFO - 'XPC_FLAGS': '0x0', 10:35:02 INFO - 'XPC_SERVICE_NAME': '0', 10:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:05 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 10:35:06 INFO - Downloading docopt-0.6.1.tar.gz 10:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:06 INFO - Running setup.py install for blobuploader 10:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:35:06 INFO - Running setup.py install for requests 10:35:07 INFO - Running setup.py install for docopt 10:35:07 INFO - Successfully installed blobuploader requests docopt 10:35:07 INFO - Cleaning up... 10:35:07 INFO - Return code: 0 10:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:07 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')]} 10:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:07 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')]} 10:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:07 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35:07 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 10:35:07 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 10:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:07 INFO - 'HOME': '/Users/cltbld', 10:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:07 INFO - 'LOGNAME': 'cltbld', 10:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:07 INFO - 'MOZ_NO_REMOTE': '1', 10:35:07 INFO - 'NO_EM_RESTART': '1', 10:35:07 INFO - 'PAGER': '/bin/cat', 10:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:07 INFO - 'PWD': '/builds/slave/test', 10:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:07 INFO - 'SHELL': '/bin/bash', 10:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:07 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:07 INFO - 'USER': 'cltbld', 10:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:07 INFO - 'XPC_FLAGS': '0x0', 10:35:07 INFO - 'XPC_SERVICE_NAME': '0', 10:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:07 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-mRu5UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:07 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-2ZoZrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:07 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-a30JmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:07 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-xr8Xw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-HY04tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-swQPNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-rwGAvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-vpk9kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-YiSiQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-bSWdrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-XrQHMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-9MnGrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-aPk4nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:08 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-GrBd50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:09 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-o3YUH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:09 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Hjf9nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:09 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-962itv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:35:09 INFO - Running setup.py install for manifestparser 10:35:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:35:09 INFO - Running setup.py install for mozcrash 10:35:09 INFO - Running setup.py install for mozdebug 10:35:09 INFO - Running setup.py install for mozdevice 10:35:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:35:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:35:09 INFO - Running setup.py install for mozfile 10:35:10 INFO - Running setup.py install for mozhttpd 10:35:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Running setup.py install for mozinfo 10:35:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Running setup.py install for mozInstall 10:35:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Running setup.py install for mozleak 10:35:10 INFO - Running setup.py install for mozlog 10:35:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Running setup.py install for moznetwork 10:35:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:35:10 INFO - Running setup.py install for mozprocess 10:35:11 INFO - Running setup.py install for mozprofile 10:35:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:35:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:35:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:35:11 INFO - Running setup.py install for mozrunner 10:35:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:35:11 INFO - Running setup.py install for mozscreenshot 10:35:11 INFO - Running setup.py install for moztest 10:35:11 INFO - Running setup.py install for mozversion 10:35:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:35:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:35:11 INFO - Cleaning up... 10:35:11 INFO - Return code: 0 10:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35:11 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')]} 10:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:11 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')]} 10:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:11 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35:11 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 10:35:11 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 10:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:11 INFO - 'HOME': '/Users/cltbld', 10:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:11 INFO - 'LOGNAME': 'cltbld', 10:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:11 INFO - 'MOZ_NO_REMOTE': '1', 10:35:11 INFO - 'NO_EM_RESTART': '1', 10:35:11 INFO - 'PAGER': '/bin/cat', 10:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:11 INFO - 'PWD': '/builds/slave/test', 10:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:11 INFO - 'SHELL': '/bin/bash', 10:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:11 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:11 INFO - 'USER': 'cltbld', 10:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:11 INFO - 'XPC_FLAGS': '0x0', 10:35:11 INFO - 'XPC_SERVICE_NAME': '0', 10:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-5Y7K1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-hXFyzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-yBtWPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-8gcyPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-Swpj2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-1yo67_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-gyAbc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:35:12 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)) 10:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:35:12 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-3V0niR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-j9jTaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-vzM_R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-4D7OfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-TisLcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-_tNOOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-yolvnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-SjY67_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-LEYwSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:35:13 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)) 10:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:35:13 INFO - Running setup.py (path:/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/pip-v8q6nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:35:14 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)) 10:35:14 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)) 10:35:14 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)) 10:35:14 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)) 10:35:14 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)) 10:35:14 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)) 10:35:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:35:14 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 10:35:14 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 10:35:14 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 10:35:14 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 10:35:14 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 10:35:14 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 10:35:16 INFO - Downloading blessings-1.6.tar.gz 10:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:35:16 INFO - Installing collected packages: blessings 10:35:16 INFO - Running setup.py install for blessings 10:35:16 INFO - Successfully installed blessings 10:35:16 INFO - Cleaning up... 10:35:17 INFO - Return code: 0 10:35:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:17 INFO - Reading from file tmpfile_stdout 10:35:17 INFO - Current package versions: 10:35:17 INFO - blessings == 1.6 10:35:17 INFO - blobuploader == 1.2.4 10:35:17 INFO - docopt == 0.6.1 10:35:17 INFO - functools32 == 3.2.3-2 10:35:17 INFO - jsonschema == 2.5.1 10:35:17 INFO - manifestparser == 1.1 10:35:17 INFO - mozInstall == 1.12 10:35:17 INFO - mozcrash == 1.0 10:35:17 INFO - mozdebug == 0.1 10:35:17 INFO - mozdevice == 0.48 10:35:17 INFO - mozfile == 1.2 10:35:17 INFO - mozhttpd == 0.7 10:35:17 INFO - mozinfo == 0.9 10:35:17 INFO - mozleak == 0.1 10:35:17 INFO - mozlog == 3.4 10:35:17 INFO - moznetwork == 0.27 10:35:17 INFO - mozprocess == 0.23 10:35:17 INFO - mozprofile == 0.28 10:35:17 INFO - mozrunner == 6.13 10:35:17 INFO - mozscreenshot == 0.1 10:35:17 INFO - mozsystemmonitor == 0.3 10:35:17 INFO - moztest == 0.7 10:35:17 INFO - mozversion == 1.4 10:35:17 INFO - psutil == 3.1.1 10:35:17 INFO - requests == 1.2.3 10:35:17 INFO - wsgiref == 0.1.2 10:35:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:17 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 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35:17 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 10:35:17 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 10:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:17 INFO - 'HOME': '/Users/cltbld', 10:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:17 INFO - 'LOGNAME': 'cltbld', 10:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:17 INFO - 'MOZ_NO_REMOTE': '1', 10:35:17 INFO - 'NO_EM_RESTART': '1', 10:35:17 INFO - 'PAGER': '/bin/cat', 10:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:17 INFO - 'PWD': '/builds/slave/test', 10:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:17 INFO - 'SHELL': '/bin/bash', 10:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:17 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:17 INFO - 'USER': 'cltbld', 10:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:17 INFO - 'XPC_FLAGS': '0x0', 10:35:17 INFO - 'XPC_SERVICE_NAME': '0', 10:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 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)) 10:35:17 INFO - Cleaning up... 10:35:17 INFO - Return code: 0 10:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10414a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe772c7c3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, '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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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 10:35: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', 'jsonschema'] in /builds/slave/test/build 10:35: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 jsonschema 10:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:17 INFO - 'HOME': '/Users/cltbld', 10:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:17 INFO - 'LOGNAME': 'cltbld', 10:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:17 INFO - 'MOZ_NO_REMOTE': '1', 10:35:17 INFO - 'NO_EM_RESTART': '1', 10:35:17 INFO - 'PAGER': '/bin/cat', 10:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:17 INFO - 'PWD': '/builds/slave/test', 10:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:17 INFO - 'SHELL': '/bin/bash', 10:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:17 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:17 INFO - 'USER': 'cltbld', 10:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:17 INFO - 'XPC_FLAGS': '0x0', 10:35:17 INFO - 'XPC_SERVICE_NAME': '0', 10:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:35:17 INFO - Cleaning up... 10:35:17 INFO - Return code: 0 10:35:17 INFO - Running post-action listener: _resource_record_post_action 10:35:17 INFO - Running post-action listener: _start_resource_monitoring 10:35:17 INFO - Starting resource monitoring. 10:35:17 INFO - [mozharness: 2016-11-29 18:35:17.870598Z] Finished create-virtualenv step (success) 10:35:17 INFO - [mozharness: 2016-11-29 18:35:17.871543Z] Running install step. 10:35:17 INFO - Running pre-action listener: _resource_record_pre_action 10:35:17 INFO - Running main action method: install 10:35:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:35:18 INFO - Reading from file tmpfile_stdout 10:35:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:35:18 INFO - Reading from file tmpfile_stdout 10:35:18 INFO - Output received: 10:35:18 INFO - Usage: mozinstall [options] installer 10:35:18 INFO - Options: 10:35:18 INFO - -h, --help show this help message and exit 10:35:18 INFO - -d DEST, --destination=DEST 10:35:18 INFO - Directory to install application into. [default: 10:35:18 INFO - "/builds/slave/test"] 10:35:18 INFO - --app=APP Application being installed. [default: firefox] 10:35:18 INFO - mkdir: /builds/slave/test/build/application 10:35:18 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'] 10:35:18 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 10:35:49 INFO - Reading from file tmpfile_stdout 10:35:49 INFO - Output received: 10:35:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:35:49 INFO - Running post-action listener: _resource_record_post_action 10:35:49 INFO - [mozharness: 2016-11-29 18:35:49.335819Z] Finished install step (success) 10:35:49 INFO - [mozharness: 2016-11-29 18:35:49.335978Z] Running run-tests step. 10:35:49 INFO - Running pre-action listener: _resource_record_pre_action 10:35:49 INFO - Running main action method: run_tests 10:35:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:35:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:35:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:35:49 INFO - 2016-11-29 10:35:49.351 screenresolution[1636:7422] starting screenresolution argv=screenresolution get 10:35:49 INFO - 2016-11-29 10:35:49.353 screenresolution[1636:7422] Display 0: 1600x1200x32@60 10:35:49 INFO - 2016-11-29 10:35:49.360 screenresolution[1637:7424] starting screenresolution argv=screenresolution list 10:35:49 INFO - Available Modes on Display 0 10:35:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:35:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:35:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:35:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:35:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:35:49 INFO - Intel Iris: 10:35:49 INFO - Chipset Model: Intel Iris 10:35:49 INFO - Type: GPU 10:35:49 INFO - Bus: Built-In 10:35:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:35:49 INFO - Vendor: Intel (0x8086) 10:35:49 INFO - Device ID: 0x0a2e 10:35:49 INFO - Revision ID: 0x0009 10:35:49 INFO - Displays: 10:35:49 INFO - Display: 10:35:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:35:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:35:49 INFO - Display Serial Number: 1600x1200 60 10:35:49 INFO - Main Display: Yes 10:35:49 INFO - Mirror: Off 10:35:49 INFO - Online: Yes 10:35:49 INFO - Rotation: Supported 10:35:49 INFO - Return code: 0 10:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:35:49 INFO - Python 2.7.3 10:35:49 INFO - Return code: 0 10:35:49 INFO - grabbing minidump binary from tooltool 10:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:49 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 0x103fe8d30>, '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 0x103e4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fe0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:35:49 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 10:35:49 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 10:35:49 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 10:35:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:35:49 INFO - Return code: 0 10:35:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:35:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:35:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:35:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:35:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:35:49 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/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--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 10:35:49 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/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0257 --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 10:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hV3s3sAUZD/Render', 10:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:35:49 INFO - 'HOME': '/Users/cltbld', 10:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:35:49 INFO - 'LOGNAME': 'cltbld', 10:35:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:35:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:49 INFO - 'MOZ_NO_REMOTE': '1', 10:35:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:35:49 INFO - 'NO_EM_RESTART': '1', 10:35:49 INFO - 'PAGER': '/bin/cat', 10:35:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:49 INFO - 'PWD': '/builds/slave/test', 10:35:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:35:49 INFO - 'SHELL': '/bin/bash', 10:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ORQmhAbZTg/Listeners', 10:35:49 INFO - 'TMPDIR': '/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/', 10:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:35:49 INFO - 'USER': 'cltbld', 10:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:49 INFO - 'XPC_FLAGS': '0x0', 10:35:49 INFO - 'XPC_SERVICE_NAME': '0', 10:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:35:49 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/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--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 10:35:49 INFO - mozversion application_buildid: 20161129080327 10:35:49 INFO - mozversion application_changeset: af6fea4fe3c79e74b04f669ac3973cd69dd534a3 10:35:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:35:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:35:49 INFO - mozversion application_name: Firefox 10:35:49 INFO - mozversion application_remotingname: firefox-dev 10:35:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:49 INFO - mozversion application_vendor: Mozilla 10:35:49 INFO - mozversion application_version: 52.0a2 10:35:49 INFO - mozversion platform_buildid: 20161129080327 10:35:49 INFO - mozversion platform_changeset: af6fea4fe3c79e74b04f669ac3973cd69dd534a3 10:35:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:35:49 INFO - mozversion platform_version: 52.0a2 10:35:49 INFO - using testdate: 1480444549 10:35:49 INFO - actual date: 1480444549 10:35:49 INFO - starting webserver on 'localhost:49236' 10:35:49 INFO - SUITE-START | Running 2 tests 10:35:49 INFO - TEST-START | dromaeo_css 10:35:49 INFO - operating with platform_type : mac_ 10:35:49 INFO - Initialising browser for dromaeo_css test... 10:35:49 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpIelBf9/profile http://localhost:49236/getInfo.html) 10:35:52 INFO - PROCESS | 1647 | 2016-11-29 10:35:52.928 plugin-container[1649:7613] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 10:35:52 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:52 INFO - PROCESS | 1647 | 2016-11-29 10:35:52.931 plugin-container[1649:7613] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b0f, name = 'com.apple.CFPasteboardClient' 10:35:52 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:52 INFO - PROCESS | 1647 | 2016-11-29 10:35:52.931 plugin-container[1649:7613] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:35:53 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 10:35:53 INFO - PROCESS | 1647 | colorDepth:24 10:35:53 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 10:35:53 INFO - PROCESS | 1647 | __metrics 10:35:53 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:35:53 INFO - TEST-INFO | 1647: exit 0 10:35:53 INFO - Browser initialized. 10:35:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:35:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpIelBf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:56 INFO - PROCESS | 1650 | 2016-11-29 10:35:56.563 plugin-container[1651:7738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 10:35:56 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:56 INFO - PROCESS | 1650 | 2016-11-29 10:35:56.563 plugin-container[1651:7738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 10:35:56 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:35:56 INFO - PROCESS | 1650 | 2016-11-29 10:35:56.563 plugin-container[1651:7738] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:36:06 INFO - PROCESS | 1650 | RSS: Main: 230506496 10:36:06 INFO - PROCESS | 1650 | 10:36:55 INFO - PROCESS | 1650 | 1480444615816 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] 10:39:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:39:11 INFO - PROCESS | 1650 | RSS: Main: 234631168 10:39:11 INFO - PROCESS | 1650 | 10:42:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:42:14 INFO - PROCESS | 1650 | RSS: Main: 245215232 10:42:14 INFO - PROCESS | 1650 | 10:45:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:45:16 INFO - PROCESS | 1650 | RSS: Main: 248049664 10:45:16 INFO - PROCESS | 1650 | 10:48:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:48:19 INFO - PROCESS | 1650 | RSS: Main: 248098816 10:48:19 INFO - PROCESS | 1650 | 10:51:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:51:23 INFO - PROCESS | 1650 | RSS: Main: 251408384 10:51:23 INFO - PROCESS | 1650 | 10:54:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:54:26 INFO - PROCESS | 1650 | RSS: Main: 252944384 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | __start_tp_report 10:54:26 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:54:26 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:54:26 INFO - PROCESS | 1650 | |i|pagename|runs| 10:54:26 INFO - PROCESS | 1650 | |0;dojo.html;2867.3691787806683;3381.983090084551;3390.1355154435614;3402.7107695845853;3429.725621950244;4631.7915693793775;5425.914817036593;5707.258056452661;5718.228039214705;5734.254546908896;5651.802186923458;5698.943010569893;5719;5741.454561816631;5749.885002299962;5023.246513023039;5183.818566350188;5223.190405487156;5233.65981211222;5234.502722241381;4512.751798651073;5120.820771273006;5281.8943621127555;5295.629305948585;5310.761015754281;5172.6379153459275;5176.948230517703;5287.682739035651;5291.947080529184;5323;5228.215767634866;5231.424543300215;5264.368275806928;5273.050850846846;5282.81510147143;5115.61632877532;5210.713410762407;5214.4524824893215;5216.26972223889;5222.973885130588;5778.624389414675;5823.359430462688;5868.941310586925;5873.823785286449;5943.286805583314;5228.686278823283;5507.862303442406;6178.567500274982;6239.2824825145235;6271.3728627136925;6120.386183820725;6184.474319682832;6256.6871656417;6289.0880822280515;6296.212973378328;5816.069428891357;5819.505342045889;5822.8645414144685;5823.767049318065;5826.184334193216;6182.227221597301;6184.257889053252;6198.442140207403;6233;6243.469305109116;6113.4154954094565;6150.138980542728;6151.384861513813;6173.074038894202;6238.906416403667;6256.749730010749;6258.468030217483;6267.310595834455;6271.122042913996;6279.3720627937755;6081.422264884829;6166.445019948136;6191.84520386994;6262.906056409158;6285.43431091204;5448.073827449343;6013.128096426081;6226.59527130735;6229.0967809667345;6236.251649802053;4947.727874966911;4967.677100988424;4971.801127954914;4975.029869175476;5009.949900501021;4297.355396690459;4396.516383197845;4402.25161722508;4410.07388448423;4449.555044495524;4630.4443466784205;5756.107803290497;5909.852253693606;5927.525797936155;5947.762089516457;6247.250329960434;6258.593191442633;6267.811965641038;6308.54903372227;6315.621062736251;5805.419458054161;5849.327327357323;5851.795187168514;5870.765169393177;5942.70286485674;4563.840265590688;5397.622166448389;5398.379186393537;5438.510534051954;5484.835454936278;6341.207349081273;6366.427021568081;6367.777127800598;6397.744090236339;6406.839829004126;6172.845678858064;6206.06908963659;6214.9067763982675;6220.942439785157;6242.843928901813;6373.458256048102;6396.936030639634;6410.519211059096;6415.903761443488;6421.293657697743;6170.074488826533;6215.409536094064;6244.781432649836;6262.1546091278915;6262.373762623702;6089.939100608937;6166.260048794174;6190;6192.938070619236;6270.184875966095;6045.939540604538;6082.178905847831;6110.012029148232;6112.351504965139;6117.388261173847;6051.7579296827635;6071.301800293023;6097.5731698780655;6117.235345581802;6121;5820.243368362086;5832.066869300891;5909.763609455746;5931.317898441562;5983.431574000463;6092.208012958287;6113.050656958906;6114.723190878713;6115.908261376172;6123.618175568305;6006.729697163551;6058.57589968698;6062.909056364247;6062.969685151546;6087.117367981707 10:54:26 INFO - PROCESS | 1650 | |1;ext.html;457.81916143123465;492.21737437474417;516.2591680937852;522.46969326134;541.3828235811176;37746.62253377469;39220.41169382458;39344;39383.80308098455;39385;40119.79940100303;40445;40458.7977060115;40619.9845003875;40704;7226.674799634003;7976.680932762712;9264.39781414206;9427.387219830689;9448.102430269113;9241.214496767783;9326.880774307092;9331.440113593206;9346.81306373872;9362.970073291932;9287.95356023219;9347.29895257855;9356.672516461926;9373.203277721403;9375.390599611037;9273;9320.906790932106;9322.580483878242;9348.57931393082;9373.671921482715;9208.585613647401;9312.953435232848;9327.393719408217;9328.113829186217;9331.346805723602;29035.709642903723;38715.61284387148;38983.61016389828;39064.414033789515;39171.80414097911;3181.3796309719614;3279.5736554248033;3313.8840140595203;3332.6167490738635;3807.219519998421;27830.721692783016;28331;29777.10668679943;30600.622971966313;31028.844855775576;3136.9843150784327;3151.9369612607848;3176.4600017996995;3202.119417160276;3215.8713651453913;373948.1302593497;375674;376956;377352.2456264932;378875;55935.16097258544;55996;56258.71870640621;56395.71802140963;56424.71787641035;57020.429795702345;57287.14069288964;57415;57459.71270143623;57569.272921812415;15198.544043678707;15535.223238838013;15741;15763.684726305639;15818.971766835119;12283;12307.953823924887;12370.82477164668;12371.628851134481;12419.44112514939;13072.346382680827;14525.983181177216;14927.25363731809;14940.925295373454;14978.775318370233;3166.60417447819;5377.112776391851;6599;6640.734370625218;6664.566803157779;840.4159109419018;944.5418971798672;964.1226483899758;1051.9000694933968;1065.2330322168027;30167.698323016928;30816.84591577028;31084.68915310818;32124.269437098108;32445.675543244266;819.6270696832927;928.8653145293895;935.9625614975461;1036.8185567525652;1041.6093964763213;13069.542566010334;13736.313184340743;14008.789868151986;14572.854271457361;14880.479183228752;687452;691951;693054;694630;696993;53099.93800123976;53713;53721.65695857635;53854;53862;1348.5617174418157;1363.2638375277438;1376.0917794255743;1379.2069560003038;1384.5431007767413;25436.982520698966;27922.441551169268;28584.714152858207;28621.427571448872;28868.566971495864;45002;48291.75854120707;48401.7899552514;48412.7579362115;48512.757436212596;616644;617273;620102;622552;623559.8822005861;24484.51030979406;25222.74777252204;25545;25588.7205639721;25686.458812471312;35222.64777352194;43633.78183109191;44400;44612.10775784401;44695.55304446914;35923.82038089793;36055;37041;37171.44242836306;37367.25265494729;36366;36588.63411365959;36956;37050;37479.43780843344;30492.542611861285;31237.375252495276;35067.473987889694;35602.753903614284;35809.82095089508;31078.223044423165;32412.675873240965;32535.186620333734;32539.674603253665;32705;20624.58750825005;24461.755382445946;24645.753542464347;24651.876740616182;24914.750852491245 10:54:26 INFO - PROCESS | 1650 | |2;jquery.html;321.39256804639234;363.6290983197137;373.3261463059178;382.8085957021489;394.8381163722874;18280.45158645241;19376.806231937677;19530.609387812234;19578.314758983437;19823.5044123897;18807.529811754714;19059.71410428841;19504.02479876004;19594.510137246576;19614.901925490354;5649.576281778863;5671.461211184941;5970.373110823366;5972.25346831646;5978.760849566034;5705.914411283834;5871.735771890254;5884.4703976642095;5887.558433117512;5891.263592050994;5543.752655652486;5702.77188912443;5808.970955145219;5817.447342502455;5834.649921004753;5746.798862039829;5751.4248575142365;5780.421957804228;5788.739506722187;5789.507891829199;4983.177775667011;5008.123578373807;5070.706969722697;5087.745612719349;5090.796368145269;23861.403464913517;24183.274501764976;24250.514989700285;24277.635835462483;24509.509809803883;1972.9704054439194;2224.8665080095084;2301.873396963166;2459.4097416619884;2962.4371369439955;11973.640790776291;12370.381480926007;14017.859821401757;14136.575902722934;15458.613534661723;1794.0491539483965;1839.9080045997646;1883.8131976854631;1889.7070954002152;1917.5781328107794;117552;119705;120456.99999999913;122422;122675;9136.360454768102;9501.429914205031;11372.374519401512;11394.860513948539;11408.88591114095;13962.441502339792;14121.364538595788;14143.64640883986;14143.71712565743;14156.716865662629;6919.965400172967;8086.959565202136;8456.8731469028;8470.534120623424;8525.232729054414;8254.669813207525;8256.958715206385;8275.131111233355;8373.120822313691;8397.370197235232;4466.57567531084;4487.551244875486;4504.031633198878;4504.414426124648;4578.771061446981;1771.2383675019607;1904.8190421909896;1987.0561483295319;1991.2134706791026;2003.3689387842783;257.71265039481216;364.48789450821636;397.89385508287006;808.6199486241575;915.2769312243387;11305.434728263554;11573.537058517564;11591.24656897299;11676.88323116758;11999.88000120005;409.4268024765352;413.72487295948457;428.76846502888714;434.2119053917193;435.555733152183;4982.850514484571;5813.79651712188;5975.671338076448;6024.789132380346;6041.848953776191;306784;306940.4652976721;378864;597578;618341;109451;129853.40293194272;132978;133542;138409;955.9713208603753;992.8609994600762;998.9910190707293;1008.6973907827622;1011.175891648319;17442.651146977245;17999.460016199537;18402.72395914089;18414.907925460822;18500;53602.463975359744;53822;54276.72861635667;56675.43324566867;56705.149422757866;75491.62254188694;77470;78180;78332;79464.60267698625;6523.739050437929;7215.567065976058;7697.422693297913;7943.4042446817875;8013.2387423194705;11505.252158609663;12159.878401216229;12277.263364198177;12301.384930753606;12410.193337433038;10434.947825260826;10608.946955265483;10671.253012289066;10727.034566889017;10867.782644347228;10289.176865850564;10449.68650940473;10538.262321637412;10585.576576937145;10701.946490267499;10692.572297108029;10761.623343182951;10837.187210959051;10977.945110274397;11131.72170695739;7831.373490120891;7892.960535197287;8006.239407256301;8033.718819841278;8098.676052957816;10059.949700251453;10516.421596812248;10526.31578947366;10719.946400267949;10752.40861752611 10:54:26 INFO - PROCESS | 1650 | |3;mootools.html;1443.0836418874014;1480.2598700649676;1636.9345226190953;1778.7687600611919;1807.5932915094113;7490.138634057085;7753.651085701143;7943.841123177533;8397.832043359129;8408.117147699495;7833.295003449688;8109.472884262519;8125.837483250331;8231.42380033398;8248;2133.8186254168413;2244.70818793557;2298.6666933294746;2303.021215983209;2306.4695120122383;1956.853236007298;2107.7470703515523;2288.3592594073602;2326.2439707095264;2327.1273272522803;2280.726312842453;2289.3132060381818;2293.1286111277773;2304.608216603173;2319.3273950554317;2205.1730601024615;2206.856554323972;2213.9335819925427;2216.7672394398596;2217.1131547381015;2275.533515629292;2303.4817166137655;2303.953920921589;2305.792478676927;2310.607196776552;8174.3051840593025;8210.466319689202;8243.381746368987;8265.380096492787;8287.254147126787;5036.571891389236;5191.454897235812;5194.584433245332;5195.480451954812;5198.038362902837;3178.761592880543;3240.821754803485;3430.6569343065494;3442.1910850950258;3443.810590417526;895.9238464730506;1005.6631028605426;1057.6826951914395;1066.9253152279343;1074.6507385099874;10318.277720559563;10533.525991330409;10557.472126393726;10765.407902565355;10821.242513024092;4292.892677683083;4334.241507736134;4416.734995900256;4439.667024973075;4465.508794032654;8457.57712114404;8549.615267312985;8549.957250213834;8558.871616925751;8560.529170895661;5015.3229314042865;5019.247112933089;5021.4225364083595;5032;5042.067217564762;3720.3489389356755;4240.109576988805;4347.934755984804;4715.481297057321;4716.1510928033285;2904.724051215131;3138.1840721412595;3625.2568223514118;3683.4658974448553;3712.7215458840697;1129.5255992483176;1138.2601309148954;1146.7075895646556;1151.9251248668809;1154.2728081308721;875.518464844333;882.8057827277988;888.6090120347027;888.8977767556685;911.6444586611227;5373.681614595601;5567.025770490229;5591.105423132361;5655.1799989001365;5688.857778555569;345.2421933855214;359.23841456113206;363.8817384350097;430.01311988985356;438.24840398716356;3433.866823948091;3750.662440380379;3812.218495208476;3829.5021647185686;3960.207958408272;8232.958835205785;9155.908440915638;9872.901270987342;9994.500274986221;9996.600135994624;9557.665481708107;9928.056834600846;9948.552315145836;9962.103410693073;10013.449260290608;6701.262861085277;7395.926040739631;7748.8376743488925;7775.727849525239;7788.727394541163;5408.350997880122;5528.06022976087;5530.866172434561;5554.805581804618;5624.85937851557;8891.955540222258;9152.267818574632;9216.447013179231;9221.86167207479;9303.488308143116;9216.124468175512;9313.674021409219;9339.159475647224;9377.812443751223;9451.291153163678;6485.902711459237;6711.395974362331;6986.16166060076;7160.641967901688;7165.0327205828635;7425.517341372793;7655.387568994578;7691.30778229962;7782.844343113219;7787.10448298453;6935.063766391674;7147.678354473957;7147.964260178874;7156.355927966508;7201.71193152268;6947.201071876799;6999.51003429755;7011.859762804817;7039.331263529956;7045.471589630901;5704.572157088152;6472.773452929125;6553.475721942138;6663.566868153554;6673.499487538357;4821.879453013703;4834.057358814997;4855.368802055851;4875.536824001714;4880.829170978998;4812.975935120302;4823.324734537097;4937.802487900587;4944.332515110558;4946.233333833117 10:54:26 INFO - PROCESS | 1650 | |4;prototype.html;298.98355590442526;300.7834359261332;303.6811348084511;308.68976678438173;313.2622673603663;5155.871103222412;5313.548348390392;5345.305110335656;5445.319335083114;5453.427390124034;4795.889808484265;5127.512886275807;5266.236395722618;5280.339957505312;5296.496832800887;4075.735077219986;4088.284550203717;4090.5704900985415;4095.3380302803266;4103.446034785311;3771.264603402338;3973.370917923652;4082.101937573729;4113.9177216455655;4114.300568903293;3493.3188028334484;3785.678217351515;3992.7604343739467;4002.359622460407;4045.361628540446;3610.5667319921513;3787.844707364253;4013.7391069580385;4018.738781979162;4024.1348110156164;3331.267121233325;3515.8221995631493;3522.3131489359585;3530.3998320285614;3531.964680353189;4914.164592019365;5163.432022477525;5177;5201.479852014806;5241.895162096775;4309.418228539138;4570.731926672445;4571.9314210286875;4599.655025873073;4614.238650622643;5349.411564727877;5618.57860660448;5624.943750562483;5636.4927156556105;5655.915161272585;3485.5012344691772;3749.325121478133;3806.830106839103;3808.276427478798;3838.827252773604;4431.490378606437;4494.292248843983;5844.824655260307;5867.471927526543;5914;3004.1438190115714;3607.9639203607626;3636.8908932731533;3688.5573731152435;3892.474515940312;3291.769576129648;3796.3166630006313;3875.4961854958674;3940.4483372327895;3952.347862602696;4284.67864910133;4301.634361079281;4569.246074397687;4593.724376537419;4621.989434595962;5375.408705042442;5539.972300138474;5711.828645140652;5726.169705392695;5727.570432217601;1007.0161781290846;1174.7944109780753;1199.802032664618;1203.1517779965104;1239.3493415956696;782.4390341269204;834.8413801377719;837.4389159263308;863.1756672377865;873.5763154869883;4449.977750111293;4717.9292310615365;4836.34001299284;5049.368828896388;5062.82280120194;4703;4795.808167673324;5077.771500282496;5300.893982120413;5537.750801213955;4285.928517870532;4327.65378769704;4479.297866810656;4557;4965.627577931669;2260.2202240227093;2704.4591081783724;2900.4489147062413;2946.2634341414646;2951;5056.648658373874;5382.478717877002;5445.319335083114;5719.828405147852;5808.796692115756;5508.55931525477;5591.944080559142;5753.88492230153;5760.2223699800825;5920.615160014585;6017.819465416044;6112.694365281718;6127.632342059491;6139.986902161093;6143.662098584621;5802;5945.286565612154;5951.434613711691;5963.211036689063;5974.790882319098;4845.636577256791;5374.623776335619;5720.656760594377;5749;5845.217208751202;5786.363500014911;5821.27234095738;6109.511239100772;6152.323244443018;6162.938370616236;3838.078861073378;3845.961640330629;3963.6234557718126;3996.6403023728003;4051.2707712612014;5489.615726899079;5758.107493338372;5767.596268261182;5781.4218578141845;5819.301683797971;4542.023464954918;4578.5650363215445;4859.271109333628;5152.355955505562;5494.011078005838;5402.945970540244;5630.943690563206;5648.57635677334;5670.291213598301;5678.346990096192;4130.876073717794;4814.831480898151;4907.27047443938;5558.97220513911;5560.972195138998;4617.284320930261;4817.880132741582;5682.176084467812;5682.516986056232;5733.426657334233;5521.613487055867;5523.226748255328;5545.474994376579;5562.165675148598;5590.853874955706 10:54:26 INFO - PROCESS | 1650 | |5;yui.html;671.5668393885944;684.661092759084;760.2549501488545;761.6839011810096;787.5274835098942;12341.25952442854;14022.368993395296;14822.629434264121;14840.480583179591;14891.553253402388;13347.998900082484;13363.198208107497;13380.799288010687;13412;13507.392167352467;634.3846468925146;657.6744511466807;792.3067316098413;818.0837462042521;826.0087894526562;810.3355248696072;823.9988414076895;826.5123577089516;826.9503829770202;828.3166387730116;872.742540950418;876.5923845411883;876.9649214031431;877.5085951866943;879.366855863777;860.3332417376552;866.0516734176067;873.4497266721957;873.9257163141141;876.9693060742875;632.5508888689036;648.2609824799732;648.3484098481043;648.5006544960354;649.337675570915;13025.804612930813;13583.388747506386;13793.10344827583;13800.171989680652;13808.516701915385;13505.257210853399;13589.932050339685;13764.793528097087;13857.099288546313;13958.860411395959;10678.199135064824;10784.191185661028;10786.73033174169;10934.890651093467;11072.058874995635;3251.2034551535025;3588.085038315239;3602.603713591503;3620.475031120473;3620.945685814715;81008.59495702543;84644;86236.56881715613;86290;86593.56703216507;10293.691189264335;10514.789704206027;10537.315074520131;10573.841392379121;10597.152227821756;18259.360922367654;21038.684419733716;21043.894780526;21060.789392106188;21136.260230891847;6042.607230530001;6123.387661233841;6774.882144446111;6914.859048257082;6998.405135563432;3546.840392182358;4091.85678501251;4183.267928112568;4186.309258972296;4212.494500659879;2901.8839246429907;3324.335132973367;3434.0899661589697;3435.9656403435647;3440.088376580208;633.9366063393624;639.0924886660953;640.7917426836296;642.6786606696652;653.6796969485014;569.7265312649869;641.5765594707564;641.9069234960905;643.9227292724903;666.074156921879;8381.874271885927;8920.643174272956;9160.908390916138;9175.495347755937;9238.399504032217;594.4590422715395;612.9049997250344;630.7957463505775;641.9454346380517;663.7554585152839;4226.260404429213;4339.587739164775;4392.472903251566;4400.44994375703;4508.301213311942;87075;108733;115581.422092889;116841.8315816831;120495.39752301358;66386;83920;103026;105200;108064.4596777011;90184;90394;91670;93879.53060234655;94929;8270.751877443687;8546.743597692079;8639.049704532623;8640.660697591884;8705.521196334263;54662;56470;56543.43456565381;56632.7168364172;60472.21767817109;59986.70006649939;76408.85386719092;77575.61212193903;80649.59675201586;81701.59149204216;13041.087123901236;13130;13167.736645267232;13214.17743162043;13431;13971.301434928417;14215.928920355333;14228;14264.144151350953;14317.284135792961;12583.301254330549;12897.226166430044;13103.672408189872;13174.086857199842;13338;13238.53665121716;13242.20546767197;13463.394147263201;13531.797023044466;13582.388792504558;10941.23411361197;12769.489220431078;12928.676783080498;12949.223046617233;13107;10542.35010080376;10979.121670266519;11045.226834121855;11266.436678165896;11450.656480305604;10496.947515262375;11127.332360058099;11368.829467557827;11376.94311528437;11392.601258955896 10:54:26 INFO - PROCESS | 1650 | __end_tp_report 10:54:26 INFO - PROCESS | 1650 | __start_cc_report 10:54:26 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,363 10:54:26 INFO - PROCESS | 1650 | __end_cc_report 10:54:26 INFO - PROCESS | 1650 | __startTimestamp1480445666017__endTimestamp 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:54:26 INFO - PROCESS | 1650 | Number of tests: 6 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5731.86 Median:5983.43 stddev:671.68 (11.2%) stddev-sans-first:635.04 10:54:26 INFO - PROCESS | 1650 | Values: 2867.4 3382.0 3390.1 3402.7 3429.7 4631.8 5425.9 5707.3 5718.2 5734.3 5651.8 5698.9 5719.0 5741.5 5749.9 5023.2 5183.8 5223.2 5233.7 5234.5 4512.8 5120.8 5281.9 5295.6 5310.8 5172.6 5176.9 5287.7 5291.9 5323.0 5228.2 5231.4 5264.4 5273.1 5282.8 5115.6 5210.7 5214.5 5216.3 5223.0 5778.6 5823.4 5868.9 5873.8 5943.3 5228.7 5507.9 6178.6 6239.3 6271.4 6120.4 6184.5 6256.7 6289.1 6296.2 5816.1 5819.5 5822.9 5823.8 5826.2 6182.2 6184.3 6198.4 6233.0 6243.5 6113.4 6150.1 6151.4 6173.1 6238.9 6256.7 6258.5 6267.3 6271.1 6279.4 6081.4 6166.4 6191.8 6262.9 6285.4 5448.1 6013.1 6226.6 6229.1 6236.3 4947.7 4967.7 4971.8 4975.0 5009.9 4297.4 4396.5 4402.3 4410.1 4449.6 4630.4 5756.1 5909.9 5927.5 5947.8 6247.3 6258.6 6267.8 6308.5 6315.6 5805.4 5849.3 5851.8 5870.8 5942.7 4563.8 5397.6 5398.4 5438.5 5484.8 6341.2 6366.4 6367.8 6397.7 6406.8 6172.8 6206.1 6214.9 6220.9 6242.8 6373.5 6396.9 6410.5 6415.9 6421.3 6170.1 6215.4 6244.8 6262.2 6262.4 6089.9 6166.3 6190.0 6192.9 6270.2 6045.9 6082.2 6110.0 6112.4 6117.4 6051.8 6071.3 6097.6 6117.2 6121.0 5820.2 5832.1 5909.8 5931.3 5983.4 6092.2 6113.1 6114.7 6115.9 6123.6 6006.7 6058.6 6062.9 6063.0 6087.1 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:68312.11 Median:208310.81 stddev:155552.93 (74.7%) stddev-sans-first:155905.86 10:54:26 INFO - PROCESS | 1650 | Values: 457.8 492.2 516.3 522.5 541.4 37746.6 39220.4 39344.0 39383.8 39385.0 40119.8 40445.0 40458.8 40620.0 40704.0 7226.7 7976.7 9264.4 9427.4 9448.1 9241.2 9326.9 9331.4 9346.8 9363.0 9288.0 9347.3 9356.7 9373.2 9375.4 9273.0 9320.9 9322.6 9348.6 9373.7 9208.6 9313.0 9327.4 9328.1 9331.3 29035.7 38715.6 38983.6 39064.4 39171.8 3181.4 3279.6 3313.9 3332.6 3807.2 27830.7 28331.0 29777.1 30600.6 31028.8 3137.0 3151.9 3176.5 3202.1 3215.9 373948.1 375674.0 376956.0 377352.2 378875.0 55935.2 55996.0 56258.7 56395.7 56424.7 57020.4 57287.1 57415.0 57459.7 57569.3 15198.5 15535.2 15741.0 15763.7 15819.0 12283.0 12308.0 12370.8 12371.6 12419.4 13072.3 14526.0 14927.3 14940.9 14978.8 3166.6 5377.1 6599.0 6640.7 6664.6 840.4 944.5 964.1 1051.9 1065.2 30167.7 30816.8 31084.7 32124.3 32445.7 819.6 928.9 936.0 1036.8 1041.6 13069.5 13736.3 14008.8 14572.9 14880.5 687452.0 691951.0 693054.0 694630.0 696993.0 53099.9 53713.0 53721.7 53854.0 53862.0 1348.6 1363.3 1376.1 1379.2 1384.5 25437.0 27922.4 28584.7 28621.4 28868.6 45002.0 48291.8 48401.8 48412.8 48512.8 616644.0 617273.0 620102.0 622552.0 623559.9 24484.5 25222.7 25545.0 25588.7 25686.5 35222.6 43633.8 44400.0 44612.1 44695.6 35923.8 36055.0 37041.0 37171.4 37367.3 36366.0 36588.6 36956.0 37050.0 37479.4 30492.5 31237.4 35067.5 35602.8 35809.8 31078.2 32412.7 32535.2 32539.7 32705.0 20624.6 24461.8 24645.8 24651.9 24914.8 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:30233.61 Median:154873.22 stddev:79287.84 (51.2%) stddev-sans-first:79478.46 10:54:26 INFO - PROCESS | 1650 | Values: 321.4 363.6 373.3 382.8 394.8 18280.5 19376.8 19530.6 19578.3 19823.5 18807.5 19059.7 19504.0 19594.5 19614.9 5649.6 5671.5 5970.4 5972.3 5978.8 5705.9 5871.7 5884.5 5887.6 5891.3 5543.8 5702.8 5809.0 5817.4 5834.6 5746.8 5751.4 5780.4 5788.7 5789.5 4983.2 5008.1 5070.7 5087.7 5090.8 23861.4 24183.3 24250.5 24277.6 24509.5 1973.0 2224.9 2301.9 2459.4 2962.4 11973.6 12370.4 14017.9 14136.6 15458.6 1794.0 1839.9 1883.8 1889.7 1917.6 117552.0 119705.0 120457.0 122422.0 122675.0 9136.4 9501.4 11372.4 11394.9 11408.9 13962.4 14121.4 14143.6 14143.7 14156.7 6920.0 8087.0 8456.9 8470.5 8525.2 8254.7 8257.0 8275.1 8373.1 8397.4 4466.6 4487.6 4504.0 4504.4 4578.8 1771.2 1904.8 1987.1 1991.2 2003.4 257.7 364.5 397.9 808.6 915.3 11305.4 11573.5 11591.2 11676.9 11999.9 409.4 413.7 428.8 434.2 435.6 4982.9 5813.8 5975.7 6024.8 6041.8 306784.0 306940.5 378864.0 597578.0 618341.0 109451.0 129853.4 132978.0 133542.0 138409.0 956.0 992.9 999.0 1008.7 1011.2 17442.7 17999.5 18402.7 18414.9 18500.0 53602.5 53822.0 54276.7 56675.4 56705.1 75491.6 77470.0 78180.0 78332.0 79464.6 6523.7 7215.6 7697.4 7943.4 8013.2 11505.3 12159.9 12277.3 12301.4 12410.2 10434.9 10608.9 10671.3 10727.0 10867.8 10289.2 10449.7 10538.3 10585.6 10701.9 10692.6 10761.6 10837.2 10977.9 11131.7 7831.4 7893.0 8006.2 8033.7 8098.7 10059.9 10516.4 10526.3 10719.9 10752.4 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5292.63 Median:5116.76 stddev:2917.79 (57.0%) stddev-sans-first:2911.64 10:54:26 INFO - PROCESS | 1650 | Values: 1443.1 1480.3 1636.9 1778.8 1807.6 7490.1 7753.7 7943.8 8397.8 8408.1 7833.3 8109.5 8125.8 8231.4 8248.0 2133.8 2244.7 2298.7 2303.0 2306.5 1956.9 2107.7 2288.4 2326.2 2327.1 2280.7 2289.3 2293.1 2304.6 2319.3 2205.2 2206.9 2213.9 2216.8 2217.1 2275.5 2303.5 2304.0 2305.8 2310.6 8174.3 8210.5 8243.4 8265.4 8287.3 5036.6 5191.5 5194.6 5195.5 5198.0 3178.8 3240.8 3430.7 3442.2 3443.8 895.9 1005.7 1057.7 1066.9 1074.7 10318.3 10533.5 10557.5 10765.4 10821.2 4292.9 4334.2 4416.7 4439.7 4465.5 8457.6 8549.6 8550.0 8558.9 8560.5 5015.3 5019.2 5021.4 5032.0 5042.1 3720.3 4240.1 4347.9 4715.5 4716.2 2904.7 3138.2 3625.3 3683.5 3712.7 1129.5 1138.3 1146.7 1151.9 1154.3 875.5 882.8 888.6 888.9 911.6 5373.7 5567.0 5591.1 5655.2 5688.9 345.2 359.2 363.9 430.0 438.2 3433.9 3750.7 3812.2 3829.5 3960.2 8233.0 9155.9 9872.9 9994.5 9996.6 9557.7 9928.1 9948.6 9962.1 10013.4 6701.3 7395.9 7748.8 7775.7 7788.7 5408.4 5528.1 5530.9 5554.8 5624.9 8892.0 9152.3 9216.4 9221.9 9303.5 9216.1 9313.7 9339.2 9377.8 9451.3 6485.9 6711.4 6986.2 7160.6 7165.0 7425.5 7655.4 7691.3 7782.8 7787.1 6935.1 7147.7 7148.0 7156.4 7201.7 6947.2 6999.5 7011.9 7039.3 7045.5 5704.6 6472.8 6553.5 6663.6 6673.5 4821.9 4834.1 4855.4 4875.5 4880.8 4813.0 4823.3 4937.8 4944.3 4946.2 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4495.48 Median:4910.72 stddev:1418.80 (28.9%) stddev-sans-first:1387.38 10:54:26 INFO - PROCESS | 1650 | Values: 299.0 300.8 303.7 308.7 313.3 5155.9 5313.5 5345.3 5445.3 5453.4 4795.9 5127.5 5266.2 5280.3 5296.5 4075.7 4088.3 4090.6 4095.3 4103.4 3771.3 3973.4 4082.1 4113.9 4114.3 3493.3 3785.7 3992.8 4002.4 4045.4 3610.6 3787.8 4013.7 4018.7 4024.1 3331.3 3515.8 3522.3 3530.4 3532.0 4914.2 5163.4 5177.0 5201.5 5241.9 4309.4 4570.7 4571.9 4599.7 4614.2 5349.4 5618.6 5624.9 5636.5 5655.9 3485.5 3749.3 3806.8 3808.3 3838.8 4431.5 4494.3 5844.8 5867.5 5914.0 3004.1 3608.0 3636.9 3688.6 3892.5 3291.8 3796.3 3875.5 3940.4 3952.3 4284.7 4301.6 4569.2 4593.7 4622.0 5375.4 5540.0 5711.8 5726.2 5727.6 1007.0 1174.8 1199.8 1203.2 1239.3 782.4 834.8 837.4 863.2 873.6 4450.0 4717.9 4836.3 5049.4 5062.8 4703.0 4795.8 5077.8 5300.9 5537.8 4285.9 4327.7 4479.3 4557.0 4965.6 2260.2 2704.5 2900.4 2946.3 2951.0 5056.6 5382.5 5445.3 5719.8 5808.8 5508.6 5591.9 5753.9 5760.2 5920.6 6017.8 6112.7 6127.6 6140.0 6143.7 5802.0 5945.3 5951.4 5963.2 5974.8 4845.6 5374.6 5720.7 5749.0 5845.2 5786.4 5821.3 6109.5 6152.3 6162.9 3838.1 3846.0 3963.6 3996.6 4051.3 5489.6 5758.1 5767.6 5781.4 5819.3 4542.0 4578.6 4859.3 5152.4 5494.0 5402.9 5630.9 5648.6 5670.3 5678.3 4130.9 4814.8 4907.3 5559.0 5561.0 4617.3 4817.9 5682.2 5682.5 5733.4 5521.6 5523.2 5545.5 5562.2 5590.9 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20660.51 Median:4199.40 stddev:30490.11 (726.1%) stddev-sans-first:30538.70 10:54:26 INFO - PROCESS | 1650 | Values: 671.6 684.7 760.3 761.7 787.5 12341.3 14022.4 14822.6 14840.5 14891.6 13348.0 13363.2 13380.8 13412.0 13507.4 634.4 657.7 792.3 818.1 826.0 810.3 824.0 826.5 827.0 828.3 872.7 876.6 877.0 877.5 879.4 860.3 866.1 873.4 873.9 877.0 632.6 648.3 648.3 648.5 649.3 13025.8 13583.4 13793.1 13800.2 13808.5 13505.3 13589.9 13764.8 13857.1 13958.9 10678.2 10784.2 10786.7 10934.9 11072.1 3251.2 3588.1 3602.6 3620.5 3620.9 81008.6 84644.0 86236.6 86290.0 86593.6 10293.7 10514.8 10537.3 10573.8 10597.2 18259.4 21038.7 21043.9 21060.8 21136.3 6042.6 6123.4 6774.9 6914.9 6998.4 3546.8 4091.9 4183.3 4186.3 4212.5 2901.9 3324.3 3434.1 3436.0 3440.1 633.9 639.1 640.8 642.7 653.7 569.7 641.6 641.9 643.9 666.1 8381.9 8920.6 9160.9 9175.5 9238.4 594.5 612.9 630.8 641.9 663.8 4226.3 4339.6 4392.5 4400.4 4508.3 87075.0 108733.0 115581.4 116841.8 120495.4 66386.0 83920.0 103026.0 105200.0 108064.5 90184.0 90394.0 91670.0 93879.5 94929.0 8270.8 8546.7 8639.0 8640.7 8705.5 54662.0 56470.0 56543.4 56632.7 60472.2 59986.7 76408.9 77575.6 80649.6 81701.6 13041.1 13130.0 13167.7 13214.2 13431.0 13971.3 14215.9 14228.0 14264.1 14317.3 12583.3 12897.2 13103.7 13174.1 13338.0 13238.5 13242.2 13463.4 13531.8 13582.4 10941.2 12769.5 12928.7 12949.2 13107.0 10542.4 10979.1 11045.2 11266.4 11450.7 10496.9 11127.3 11368.8 11376.9 11392.6 10:54:26 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:54:26 INFO - PROCESS | 1650 | 10:54:26 INFO - TEST-INFO | 1650: exit 0 10:54:26 INFO - TEST-OK | dromaeo_css | took 1116766ms 10:54:26 INFO - TEST-START | kraken 10:54:26 INFO - operating with platform_type : mac_ 10:54:26 INFO - Initialising browser for kraken test... 10:54:26 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpnbmBob/profile http://localhost:49236/getInfo.html) 10:54:29 INFO - PROCESS | 1661 | 2016-11-29 10:54:29.609 plugin-container[1662:10086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:54:29 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:29 INFO - PROCESS | 1661 | 2016-11-29 10:54:29.613 plugin-container[1662:10086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 10:54:29 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:29 INFO - PROCESS | 1661 | 2016-11-29 10:54:29.613 plugin-container[1662:10086] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:54:29 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 10:54:29 INFO - PROCESS | 1661 | colorDepth:24 10:54:29 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 10:54:29 INFO - PROCESS | 1661 | __metrics 10:54:29 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:54:30 INFO - TEST-INFO | 1661: exit 0 10:54:30 INFO - Browser initialized. 10:54:30 INFO - Running cycle 1/1 for kraken test... 10:54:30 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/T/tmpnbmBob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:33 INFO - PROCESS | 1663 | 2016-11-29 10:54:33.421 plugin-container[1664:10216] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474f, name = 'com.apple.tsm.portname' 10:54:33 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:33 INFO - PROCESS | 1663 | 2016-11-29 10:54:33.421 plugin-container[1664:10216] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 10:54:33 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:33 INFO - PROCESS | 1663 | 2016-11-29 10:54:33.421 plugin-container[1664:10216] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:54:43 INFO - PROCESS | 1663 | RSS: Main: 230424576 10:54:43 INFO - PROCESS | 1663 | 10:54:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:54:46 INFO - PROCESS | 1663 | RSS: Main: 242536448 10:54:46 INFO - PROCESS | 1663 | 10:54:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:54:50 INFO - PROCESS | 1663 | RSS: Main: 250232832 10:54:50 INFO - PROCESS | 1663 | 10:54:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:54:54 INFO - PROCESS | 1663 | RSS: Main: 254038016 10:54:54 INFO - PROCESS | 1663 | 10:54:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:54:56 INFO - PROCESS | 1663 | RSS: Main: 254382080 10:54:56 INFO - PROCESS | 1663 | 10:54:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:54:59 INFO - PROCESS | 1663 | RSS: Main: 254435328 10:54:59 INFO - PROCESS | 1663 | 10:55:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:03 INFO - PROCESS | 1663 | RSS: Main: 260251648 10:55:03 INFO - PROCESS | 1663 | 10:55:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:06 INFO - PROCESS | 1663 | RSS: Main: 259268608 10:55:06 INFO - PROCESS | 1663 | 10:55:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:55:10 INFO - PROCESS | 1663 | RSS: Main: 259473408 10:55:10 INFO - PROCESS | 1663 | 10:55:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:12 INFO - PROCESS | 1663 | RSS: Main: 258625536 10:55:12 INFO - PROCESS | 1663 | 10:55:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:15 INFO - PROCESS | 1663 | RSS: Main: 258650112 10:55:15 INFO - PROCESS | 1663 | 10:55:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:18 INFO - PROCESS | 1663 | RSS: Main: 258670592 10:55:18 INFO - PROCESS | 1663 | 10:55:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:55:22 INFO - PROCESS | 1663 | RSS: Main: 259018752 10:55:22 INFO - PROCESS | 1663 | 10:55:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:55:25 INFO - PROCESS | 1663 | RSS: Main: 258813952 10:55:25 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:55:27 INFO - PROCESS | 1663 | RSS: Main: 260640768 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | __start_tp_report 10:55:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:55:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:55:27 INFO - PROCESS | 1663 | |i|pagename|runs| 10:55:27 INFO - PROCESS | 1663 | |0;ai-astar;143;97;144;150;136;150;126;99;97;114 10:55:27 INFO - PROCESS | 1663 | |1;audio-beat-detection;148;131;137;180;152;150;119;118;145;120 10:55:27 INFO - PROCESS | 1663 | |2;audio-dft;198;205;196;202;198;191;227;274;199;196 10:55:27 INFO - PROCESS | 1663 | |3;audio-fft;82;51;61;99;55;78;81;84;75;79 10:55:27 INFO - PROCESS | 1663 | |4;audio-oscillator;83;71;92;95;98;88;89;70;72;92 10:55:27 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;90;89;91;88;103;91;136;131;89;89 10:55:27 INFO - PROCESS | 1663 | |6;imaging-darkroom;118;97;96;96;145;96;100;97;135;116 10:55:27 INFO - PROCESS | 1663 | |7;imaging-desaturate;85;101;75;130;130;89;90;90;111;88 10:55:27 INFO - PROCESS | 1663 | |8;json-parse-financial;57;60;64;87;90;87;90;79;59;59 10:55:27 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;70;71;74;80;78;72;74;76;77;75 10:55:27 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;84;87;86;88;85;84;90;85;88 10:55:27 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;169;163;151;151;173;161;148;142;222;299 10:55:27 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;172;174;173;170;173;169;173;170;173;172 10:55:27 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;71;67;68;69;67;70;68;66;71 10:55:27 INFO - PROCESS | 1663 | __end_tp_report 10:55:27 INFO - PROCESS | 1663 | __start_cc_report 10:55:27 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,977 10:55:27 INFO - PROCESS | 1663 | __end_cc_report 10:55:27 INFO - PROCESS | 1663 | __startTimestamp1480445727510__endTimestamp 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:55:27 INFO - PROCESS | 1663 | Number of tests: 14 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:125.60 Median:150.00 stddev:22.16 (14.8%) stddev-sans-first:22.59 10:55:27 INFO - PROCESS | 1663 | Values: 143.0 97.0 144.0 150.0 136.0 150.0 126.0 99.0 97.0 114.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:146.50 stddev:19.29 (13.2%) stddev-sans-first:20.24 10:55:27 INFO - PROCESS | 1663 | Values: 148.0 131.0 137.0 180.0 152.0 150.0 119.0 118.0 145.0 120.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:208.60 Median:200.50 stddev:24.98 (12.5%) stddev-sans-first:26.20 10:55:27 INFO - PROCESS | 1663 | Values: 198.0 205.0 196.0 202.0 198.0 191.0 227.0 274.0 199.0 196.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:74.50 Median:80.00 stddev:14.67 (18.3%) stddev-sans-first:15.31 10:55:27 INFO - PROCESS | 1663 | Values: 82.0 51.0 61.0 99.0 55.0 78.0 81.0 84.0 75.0 79.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:90.50 stddev:10.47 (11.6%) stddev-sans-first:11.08 10:55:27 INFO - PROCESS | 1663 | Values: 83.0 71.0 92.0 95.0 98.0 88.0 89.0 70.0 72.0 92.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:89.00 stddev:18.36 (20.6%) stddev-sans-first:19.14 10:55:27 INFO - PROCESS | 1663 | Values: 90.0 89.0 91.0 88.0 103.0 91.0 136.0 131.0 89.0 89.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:96.00 stddev:18.18 (18.9%) stddev-sans-first:19.03 10:55:27 INFO - PROCESS | 1663 | Values: 118.0 97.0 96.0 96.0 145.0 96.0 100.0 97.0 135.0 116.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:98.90 Median:86.50 stddev:18.93 (21.9%) stddev-sans-first:19.40 10:55:27 INFO - PROCESS | 1663 | Values: 85.0 101.0 75.0 130.0 130.0 89.0 90.0 90.0 111.0 88.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:73.20 Median:83.00 stddev:14.54 (17.5%) stddev-sans-first:14.20 10:55:27 INFO - PROCESS | 1663 | Values: 57.0 60.0 64.0 87.0 90.0 87.0 90.0 79.0 59.0 59.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:75.50 stddev:3.16 (4.2%) stddev-sans-first:2.86 10:55:27 INFO - PROCESS | 1663 | Values: 70.0 71.0 74.0 80.0 78.0 72.0 74.0 76.0 77.0 75.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.95 (2.3%) stddev-sans-first:2.06 10:55:27 INFO - PROCESS | 1663 | Values: 86.0 84.0 87.0 86.0 88.0 85.0 84.0 90.0 85.0 88.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:177.90 Median:166.00 stddev:48.13 (29.0%) stddev-sans-first:50.94 10:55:27 INFO - PROCESS | 1663 | Values: 169.0 163.0 151.0 151.0 173.0 161.0 148.0 142.0 222.0 299.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 10:55:27 INFO - PROCESS | 1663 | Values: 172.0 174.0 173.0 170.0 173.0 169.0 173.0 170.0 173.0 172.0 10:55:27 INFO - PROCESS | 1663 | 10:55:27 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.72 (2.5%) stddev-sans-first:1.81 10:55:27 INFO - PROCESS | 1663 | Values: 68.0 71.0 67.0 68.0 69.0 67.0 70.0 68.0 66.0 71.0 10:55:27 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:55:27 INFO - PROCESS | 1663 | 10:55:28 INFO - TEST-INFO | 1663: exit 0 10:55:28 INFO - TEST-OK | kraken | took 61839ms 10:55:28 INFO - SUITE-END | took 1178s 10:55:28 INFO - Completed test suite (00:19:38) 10:55:28 INFO - javascript benchmark 10:55:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6972.074074150301, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2867.3691787806683, 3381.983090084551, 3390.1355154435614, 3402.7107695845853, 3429.725621950244, 4631.7915693793775, 5425.914817036593, 5707.258056452661, 5718.228039214705, 5734.254546908896, 5651.802186923458, 5698.943010569893, 5719.0, 5741.454561816631, 5749.885002299962, 5023.246513023039, 5183.818566350188, 5223.190405487156, 5233.65981211222, 5234.502722241381, 4512.751798651073, 5120.820771273006, 5281.8943621127555, 5295.629305948585, 5310.761015754281, 5172.6379153459275, 5176.948230517703, 5287.682739035651, 5291.947080529184, 5323.0, 5228.215767634866, 5231.424543300215, 5264.368275806928, 5273.050850846846, 5282.81510147143, 5115.61632877532, 5210.713410762407, 5214.4524824893215, 5216.26972223889, 5222.973885130588, 5778.624389414675, 5823.359430462688, 5868.941310586925, 5873.823785286449, 5943.286805583314, 5228.686278823283, 5507.862303442406, 6178.567500274982, 6239.2824825145235, 6271.3728627136925, 6120.386183820725, 6184.474319682832, 6256.6871656417, 6289.0880822280515, 6296.212973378328, 5816.069428891357, 5819.505342045889, 5822.8645414144685, 5823.767049318065, 5826.184334193216, 6182.227221597301, 6184.257889053252, 6198.442140207403, 6233.0, 6243.469305109116, 6113.4154954094565, 6150.138980542728, 6151.384861513813, 6173.074038894202, 6238.906416403667, 6256.749730010749, 6258.468030217483, 6267.310595834455, 6271.122042913996, 6279.3720627937755, 6081.422264884829, 6166.445019948136, 6191.84520386994, 6262.906056409158, 6285.43431091204, 5448.073827449343, 6013.128096426081, 6226.59527130735, 6229.0967809667345, 6236.251649802053, 4947.727874966911, 4967.677100988424, 4971.801127954914, 4975.029869175476, 5009.949900501021, 4297.355396690459, 4396.516383197845, 4402.25161722508, 4410.07388448423, 4449.555044495524, 4630.4443466784205, 5756.107803290497, 5909.852253693606, 5927.525797936155, 5947.762089516457, 6247.250329960434, 6258.593191442633, 6267.811965641038, 6308.54903372227, 6315.621062736251, 5805.419458054161, 5849.327327357323, 5851.795187168514, 5870.765169393177, 5942.70286485674, 4563.840265590688, 5397.622166448389, 5398.379186393537, 5438.510534051954, 5484.835454936278, 6341.207349081273, 6366.427021568081, 6367.777127800598, 6397.744090236339, 6406.839829004126, 6172.845678858064, 6206.06908963659, 6214.9067763982675, 6220.942439785157, 6242.843928901813, 6373.458256048102, 6396.936030639634, 6410.519211059096, 6415.903761443488, 6421.293657697743, 6170.074488826533, 6215.409536094064, 6244.781432649836, 6262.1546091278915, 6262.373762623702, 6089.939100608937, 6166.260048794174, 6190.0, 6192.938070619236, 6270.184875966095, 6045.939540604538, 6082.178905847831, 6110.012029148232, 6112.351504965139, 6117.388261173847, 6051.7579296827635, 6071.301800293023, 6097.5731698780655, 6117.235345581802, 6121.0, 5820.243368362086, 5832.066869300891, 5909.763609455746, 5931.317898441562, 5983.431574000463, 6092.208012958287, 6113.050656958906, 6114.723190878713, 6115.908261376172, 6123.618175568305, 6006.729697163551, 6058.57589968698, 6062.909056364247, 6062.969685151546, 6087.117367981707], "value": 5688.161448587252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.81916143123465, 492.21737437474417, 516.2591680937852, 522.46969326134, 541.3828235811176, 37746.62253377469, 39220.41169382458, 39344.0, 39383.80308098455, 39385.0, 40119.79940100303, 40445.0, 40458.7977060115, 40619.9845003875, 40704.0, 7226.674799634003, 7976.680932762712, 9264.39781414206, 9427.387219830689, 9448.102430269113, 9241.214496767783, 9326.880774307092, 9331.440113593206, 9346.81306373872, 9362.970073291932, 9287.95356023219, 9347.29895257855, 9356.672516461926, 9373.203277721403, 9375.390599611037, 9273.0, 9320.906790932106, 9322.580483878242, 9348.57931393082, 9373.671921482715, 9208.585613647401, 9312.953435232848, 9327.393719408217, 9328.113829186217, 9331.346805723602, 29035.709642903723, 38715.61284387148, 38983.61016389828, 39064.414033789515, 39171.80414097911, 3181.3796309719614, 3279.5736554248033, 3313.8840140595203, 3332.6167490738635, 3807.219519998421, 27830.721692783016, 28331.0, 29777.10668679943, 30600.622971966313, 31028.844855775576, 3136.9843150784327, 3151.9369612607848, 3176.4600017996995, 3202.119417160276, 3215.8713651453913, 373948.1302593497, 375674.0, 376956.0, 377352.2456264932, 378875.0, 55935.16097258544, 55996.0, 56258.71870640621, 56395.71802140963, 56424.71787641035, 57020.429795702345, 57287.14069288964, 57415.0, 57459.71270143623, 57569.272921812415, 15198.544043678707, 15535.223238838013, 15741.0, 15763.684726305639, 15818.971766835119, 12283.0, 12307.953823924887, 12370.82477164668, 12371.628851134481, 12419.44112514939, 13072.346382680827, 14525.983181177216, 14927.25363731809, 14940.925295373454, 14978.775318370233, 3166.60417447819, 5377.112776391851, 6599.0, 6640.734370625218, 6664.566803157779, 840.4159109419018, 944.5418971798672, 964.1226483899758, 1051.9000694933968, 1065.2330322168027, 30167.698323016928, 30816.84591577028, 31084.68915310818, 32124.269437098108, 32445.675543244266, 819.6270696832927, 928.8653145293895, 935.9625614975461, 1036.8185567525652, 1041.6093964763213, 13069.542566010334, 13736.313184340743, 14008.789868151986, 14572.854271457361, 14880.479183228752, 687452.0, 691951.0, 693054.0, 694630.0, 696993.0, 53099.93800123976, 53713.0, 53721.65695857635, 53854.0, 53862.0, 1348.5617174418157, 1363.2638375277438, 1376.0917794255743, 1379.2069560003038, 1384.5431007767413, 25436.982520698966, 27922.441551169268, 28584.714152858207, 28621.427571448872, 28868.566971495864, 45002.0, 48291.75854120707, 48401.7899552514, 48412.7579362115, 48512.757436212596, 616644.0, 617273.0, 620102.0, 622552.0, 623559.8822005861, 24484.51030979406, 25222.74777252204, 25545.0, 25588.7205639721, 25686.458812471312, 35222.64777352194, 43633.78183109191, 44400.0, 44612.10775784401, 44695.55304446914, 35923.82038089793, 36055.0, 37041.0, 37171.44242836306, 37367.25265494729, 36366.0, 36588.63411365959, 36956.0, 37050.0, 37479.43780843344, 30492.542611861285, 31237.375252495276, 35067.473987889694, 35602.753903614284, 35809.82095089508, 31078.223044423165, 32412.675873240965, 32535.186620333734, 32539.674603253665, 32705.0, 20624.58750825005, 24461.755382445946, 24645.753542464347, 24651.876740616182, 24914.750852491245], "value": 18820.806945133583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.39256804639234, 363.6290983197137, 373.3261463059178, 382.8085957021489, 394.8381163722874, 18280.45158645241, 19376.806231937677, 19530.609387812234, 19578.314758983437, 19823.5044123897, 18807.529811754714, 19059.71410428841, 19504.02479876004, 19594.510137246576, 19614.901925490354, 5649.576281778863, 5671.461211184941, 5970.373110823366, 5972.25346831646, 5978.760849566034, 5705.914411283834, 5871.735771890254, 5884.4703976642095, 5887.558433117512, 5891.263592050994, 5543.752655652486, 5702.77188912443, 5808.970955145219, 5817.447342502455, 5834.649921004753, 5746.798862039829, 5751.4248575142365, 5780.421957804228, 5788.739506722187, 5789.507891829199, 4983.177775667011, 5008.123578373807, 5070.706969722697, 5087.745612719349, 5090.796368145269, 23861.403464913517, 24183.274501764976, 24250.514989700285, 24277.635835462483, 24509.509809803883, 1972.9704054439194, 2224.8665080095084, 2301.873396963166, 2459.4097416619884, 2962.4371369439955, 11973.640790776291, 12370.381480926007, 14017.859821401757, 14136.575902722934, 15458.613534661723, 1794.0491539483965, 1839.9080045997646, 1883.8131976854631, 1889.7070954002152, 1917.5781328107794, 117552.0, 119705.0, 120456.99999999913, 122422.0, 122675.0, 9136.360454768102, 9501.429914205031, 11372.374519401512, 11394.860513948539, 11408.88591114095, 13962.441502339792, 14121.364538595788, 14143.64640883986, 14143.71712565743, 14156.716865662629, 6919.965400172967, 8086.959565202136, 8456.8731469028, 8470.534120623424, 8525.232729054414, 8254.669813207525, 8256.958715206385, 8275.131111233355, 8373.120822313691, 8397.370197235232, 4466.57567531084, 4487.551244875486, 4504.031633198878, 4504.414426124648, 4578.771061446981, 1771.2383675019607, 1904.8190421909896, 1987.0561483295319, 1991.2134706791026, 2003.3689387842783, 257.71265039481216, 364.48789450821636, 397.89385508287006, 808.6199486241575, 915.2769312243387, 11305.434728263554, 11573.537058517564, 11591.24656897299, 11676.88323116758, 11999.88000120005, 409.4268024765352, 413.72487295948457, 428.76846502888714, 434.2119053917193, 435.555733152183, 4982.850514484571, 5813.79651712188, 5975.671338076448, 6024.789132380346, 6041.848953776191, 306784.0, 306940.4652976721, 378864.0, 597578.0, 618341.0, 109451.0, 129853.40293194272, 132978.0, 133542.0, 138409.0, 955.9713208603753, 992.8609994600762, 998.9910190707293, 1008.6973907827622, 1011.175891648319, 17442.651146977245, 17999.460016199537, 18402.72395914089, 18414.907925460822, 18500.0, 53602.463975359744, 53822.0, 54276.72861635667, 56675.43324566867, 56705.149422757866, 75491.62254188694, 77470.0, 78180.0, 78332.0, 79464.60267698625, 6523.739050437929, 7215.567065976058, 7697.422693297913, 7943.4042446817875, 8013.2387423194705, 11505.252158609663, 12159.878401216229, 12277.263364198177, 12301.384930753606, 12410.193337433038, 10434.947825260826, 10608.946955265483, 10671.253012289066, 10727.034566889017, 10867.782644347228, 10289.176865850564, 10449.68650940473, 10538.262321637412, 10585.576576937145, 10701.946490267499, 10692.572297108029, 10761.623343182951, 10837.187210959051, 10977.945110274397, 11131.72170695739, 7831.373490120891, 7892.960535197287, 8006.239407256301, 8033.718819841278, 8098.676052957816, 10059.949700251453, 10516.421596812248, 10526.31578947366, 10719.946400267949, 10752.40861752611], "value": 8736.950408946803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.0836418874014, 1480.2598700649676, 1636.9345226190953, 1778.7687600611919, 1807.5932915094113, 7490.138634057085, 7753.651085701143, 7943.841123177533, 8397.832043359129, 8408.117147699495, 7833.295003449688, 8109.472884262519, 8125.837483250331, 8231.42380033398, 8248.0, 2133.8186254168413, 2244.70818793557, 2298.6666933294746, 2303.021215983209, 2306.4695120122383, 1956.853236007298, 2107.7470703515523, 2288.3592594073602, 2326.2439707095264, 2327.1273272522803, 2280.726312842453, 2289.3132060381818, 2293.1286111277773, 2304.608216603173, 2319.3273950554317, 2205.1730601024615, 2206.856554323972, 2213.9335819925427, 2216.7672394398596, 2217.1131547381015, 2275.533515629292, 2303.4817166137655, 2303.953920921589, 2305.792478676927, 2310.607196776552, 8174.3051840593025, 8210.466319689202, 8243.381746368987, 8265.380096492787, 8287.254147126787, 5036.571891389236, 5191.454897235812, 5194.584433245332, 5195.480451954812, 5198.038362902837, 3178.761592880543, 3240.821754803485, 3430.6569343065494, 3442.1910850950258, 3443.810590417526, 895.9238464730506, 1005.6631028605426, 1057.6826951914395, 1066.9253152279343, 1074.6507385099874, 10318.277720559563, 10533.525991330409, 10557.472126393726, 10765.407902565355, 10821.242513024092, 4292.892677683083, 4334.241507736134, 4416.734995900256, 4439.667024973075, 4465.508794032654, 8457.57712114404, 8549.615267312985, 8549.957250213834, 8558.871616925751, 8560.529170895661, 5015.3229314042865, 5019.247112933089, 5021.4225364083595, 5032.0, 5042.067217564762, 3720.3489389356755, 4240.109576988805, 4347.934755984804, 4715.481297057321, 4716.1510928033285, 2904.724051215131, 3138.1840721412595, 3625.2568223514118, 3683.4658974448553, 3712.7215458840697, 1129.5255992483176, 1138.2601309148954, 1146.7075895646556, 1151.9251248668809, 1154.2728081308721, 875.518464844333, 882.8057827277988, 888.6090120347027, 888.8977767556685, 911.6444586611227, 5373.681614595601, 5567.025770490229, 5591.105423132361, 5655.1799989001365, 5688.857778555569, 345.2421933855214, 359.23841456113206, 363.8817384350097, 430.01311988985356, 438.24840398716356, 3433.866823948091, 3750.662440380379, 3812.218495208476, 3829.5021647185686, 3960.207958408272, 8232.958835205785, 9155.908440915638, 9872.901270987342, 9994.500274986221, 9996.600135994624, 9557.665481708107, 9928.056834600846, 9948.552315145836, 9962.103410693073, 10013.449260290608, 6701.262861085277, 7395.926040739631, 7748.8376743488925, 7775.727849525239, 7788.727394541163, 5408.350997880122, 5528.06022976087, 5530.866172434561, 5554.805581804618, 5624.85937851557, 8891.955540222258, 9152.267818574632, 9216.447013179231, 9221.86167207479, 9303.488308143116, 9216.124468175512, 9313.674021409219, 9339.159475647224, 9377.812443751223, 9451.291153163678, 6485.902711459237, 6711.395974362331, 6986.16166060076, 7160.641967901688, 7165.0327205828635, 7425.517341372793, 7655.387568994578, 7691.30778229962, 7782.844343113219, 7787.10448298453, 6935.063766391674, 7147.678354473957, 7147.964260178874, 7156.355927966508, 7201.71193152268, 6947.201071876799, 6999.51003429755, 7011.859762804817, 7039.331263529956, 7045.471589630901, 5704.572157088152, 6472.773452929125, 6553.475721942138, 6663.566868153554, 6673.499487538357, 4821.879453013703, 4834.057358814997, 4855.368802055851, 4875.536824001714, 4880.829170978998, 4812.975935120302, 4823.324734537097, 4937.802487900587, 4944.332515110558, 4946.233333833117], "value": 4207.1874947688475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.98355590442526, 300.7834359261332, 303.6811348084511, 308.68976678438173, 313.2622673603663, 5155.871103222412, 5313.548348390392, 5345.305110335656, 5445.319335083114, 5453.427390124034, 4795.889808484265, 5127.512886275807, 5266.236395722618, 5280.339957505312, 5296.496832800887, 4075.735077219986, 4088.284550203717, 4090.5704900985415, 4095.3380302803266, 4103.446034785311, 3771.264603402338, 3973.370917923652, 4082.101937573729, 4113.9177216455655, 4114.300568903293, 3493.3188028334484, 3785.678217351515, 3992.7604343739467, 4002.359622460407, 4045.361628540446, 3610.5667319921513, 3787.844707364253, 4013.7391069580385, 4018.738781979162, 4024.1348110156164, 3331.267121233325, 3515.8221995631493, 3522.3131489359585, 3530.3998320285614, 3531.964680353189, 4914.164592019365, 5163.432022477525, 5177.0, 5201.479852014806, 5241.895162096775, 4309.418228539138, 4570.731926672445, 4571.9314210286875, 4599.655025873073, 4614.238650622643, 5349.411564727877, 5618.57860660448, 5624.943750562483, 5636.4927156556105, 5655.915161272585, 3485.5012344691772, 3749.325121478133, 3806.830106839103, 3808.276427478798, 3838.827252773604, 4431.490378606437, 4494.292248843983, 5844.824655260307, 5867.471927526543, 5914.0, 3004.1438190115714, 3607.9639203607626, 3636.8908932731533, 3688.5573731152435, 3892.474515940312, 3291.769576129648, 3796.3166630006313, 3875.4961854958674, 3940.4483372327895, 3952.347862602696, 4284.67864910133, 4301.634361079281, 4569.246074397687, 4593.724376537419, 4621.989434595962, 5375.408705042442, 5539.972300138474, 5711.828645140652, 5726.169705392695, 5727.570432217601, 1007.0161781290846, 1174.7944109780753, 1199.802032664618, 1203.1517779965104, 1239.3493415956696, 782.4390341269204, 834.8413801377719, 837.4389159263308, 863.1756672377865, 873.5763154869883, 4449.977750111293, 4717.9292310615365, 4836.34001299284, 5049.368828896388, 5062.82280120194, 4703.0, 4795.808167673324, 5077.771500282496, 5300.893982120413, 5537.750801213955, 4285.928517870532, 4327.65378769704, 4479.297866810656, 4557.0, 4965.627577931669, 2260.2202240227093, 2704.4591081783724, 2900.4489147062413, 2946.2634341414646, 2951.0, 5056.648658373874, 5382.478717877002, 5445.319335083114, 5719.828405147852, 5808.796692115756, 5508.55931525477, 5591.944080559142, 5753.88492230153, 5760.2223699800825, 5920.615160014585, 6017.819465416044, 6112.694365281718, 6127.632342059491, 6139.986902161093, 6143.662098584621, 5802.0, 5945.286565612154, 5951.434613711691, 5963.211036689063, 5974.790882319098, 4845.636577256791, 5374.623776335619, 5720.656760594377, 5749.0, 5845.217208751202, 5786.363500014911, 5821.27234095738, 6109.511239100772, 6152.323244443018, 6162.938370616236, 3838.078861073378, 3845.961640330629, 3963.6234557718126, 3996.6403023728003, 4051.2707712612014, 5489.615726899079, 5758.107493338372, 5767.596268261182, 5781.4218578141845, 5819.301683797971, 4542.023464954918, 4578.5650363215445, 4859.271109333628, 5152.355955505562, 5494.011078005838, 5402.945970540244, 5630.943690563206, 5648.57635677334, 5670.291213598301, 5678.346990096192, 4130.876073717794, 4814.831480898151, 4907.27047443938, 5558.97220513911, 5560.972195138998, 4617.284320930261, 4817.880132741582, 5682.176084467812, 5682.516986056232, 5733.426657334233, 5521.613487055867, 5523.226748255328, 5545.474994376579, 5562.165675148598, 5590.853874955706], "value": 4034.966508157744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5668393885944, 684.661092759084, 760.2549501488545, 761.6839011810096, 787.5274835098942, 12341.25952442854, 14022.368993395296, 14822.629434264121, 14840.480583179591, 14891.553253402388, 13347.998900082484, 13363.198208107497, 13380.799288010687, 13412.0, 13507.392167352467, 634.3846468925146, 657.6744511466807, 792.3067316098413, 818.0837462042521, 826.0087894526562, 810.3355248696072, 823.9988414076895, 826.5123577089516, 826.9503829770202, 828.3166387730116, 872.742540950418, 876.5923845411883, 876.9649214031431, 877.5085951866943, 879.366855863777, 860.3332417376552, 866.0516734176067, 873.4497266721957, 873.9257163141141, 876.9693060742875, 632.5508888689036, 648.2609824799732, 648.3484098481043, 648.5006544960354, 649.337675570915, 13025.804612930813, 13583.388747506386, 13793.10344827583, 13800.171989680652, 13808.516701915385, 13505.257210853399, 13589.932050339685, 13764.793528097087, 13857.099288546313, 13958.860411395959, 10678.199135064824, 10784.191185661028, 10786.73033174169, 10934.890651093467, 11072.058874995635, 3251.2034551535025, 3588.085038315239, 3602.603713591503, 3620.475031120473, 3620.945685814715, 81008.59495702543, 84644.0, 86236.56881715613, 86290.0, 86593.56703216507, 10293.691189264335, 10514.789704206027, 10537.315074520131, 10573.841392379121, 10597.152227821756, 18259.360922367654, 21038.684419733716, 21043.894780526, 21060.789392106188, 21136.260230891847, 6042.607230530001, 6123.387661233841, 6774.882144446111, 6914.859048257082, 6998.405135563432, 3546.840392182358, 4091.85678501251, 4183.267928112568, 4186.309258972296, 4212.494500659879, 2901.8839246429907, 3324.335132973367, 3434.0899661589697, 3435.9656403435647, 3440.088376580208, 633.9366063393624, 639.0924886660953, 640.7917426836296, 642.6786606696652, 653.6796969485014, 569.7265312649869, 641.5765594707564, 641.9069234960905, 643.9227292724903, 666.074156921879, 8381.874271885927, 8920.643174272956, 9160.908390916138, 9175.495347755937, 9238.399504032217, 594.4590422715395, 612.9049997250344, 630.7957463505775, 641.9454346380517, 663.7554585152839, 4226.260404429213, 4339.587739164775, 4392.472903251566, 4400.44994375703, 4508.301213311942, 87075.0, 108733.0, 115581.422092889, 116841.8315816831, 120495.39752301358, 66386.0, 83920.0, 103026.0, 105200.0, 108064.4596777011, 90184.0, 90394.0, 91670.0, 93879.53060234655, 94929.0, 8270.751877443687, 8546.743597692079, 8639.049704532623, 8640.660697591884, 8705.521196334263, 54662.0, 56470.0, 56543.43456565381, 56632.7168364172, 60472.21767817109, 59986.70006649939, 76408.85386719092, 77575.61212193903, 80649.59675201586, 81701.59149204216, 13041.087123901236, 13130.0, 13167.736645267232, 13214.17743162043, 13431.0, 13971.301434928417, 14215.928920355333, 14228.0, 14264.144151350953, 14317.284135792961, 12583.301254330549, 12897.226166430044, 13103.672408189872, 13174.086857199842, 13338.0, 13238.53665121716, 13242.20546767197, 13463.394147263201, 13531.797023044466, 13582.388792504558, 10941.23411361197, 12769.489220431078, 12928.676783080498, 12949.223046617233, 13107.0, 10542.35010080376, 10979.121670266519, 11045.226834121855, 11266.436678165896, 11450.656480305604, 10496.947515262375, 11127.332360058099, 11368.829467557827, 11376.94311528437, 11392.601258955896], "value": 7233.08968072189, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 97.0, 144.0, 150.0, 136.0, 150.0, 126.0, 99.0, 97.0, 114.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 137.0, 180.0, 152.0, 150.0, 119.0, 118.0, 145.0, 120.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 205.0, 196.0, 202.0, 198.0, 191.0, 227.0, 274.0, 199.0, 196.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 51.0, 61.0, 99.0, 55.0, 78.0, 81.0, 84.0, 75.0, 79.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 92.0, 95.0, 98.0, 88.0, 89.0, 70.0, 72.0, 92.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 91.0, 88.0, 103.0, 91.0, 136.0, 131.0, 89.0, 89.0], "value": 99.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 97.0, 96.0, 96.0, 145.0, 96.0, 100.0, 97.0, 135.0, 116.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 101.0, 75.0, 130.0, 130.0, 89.0, 90.0, 90.0, 111.0, 88.0], "value": 98.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 64.0, 87.0, 90.0, 87.0, 90.0, 79.0, 59.0, 59.0], "value": 73.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 74.0, 80.0, 78.0, 72.0, 74.0, 76.0, 77.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 88.0, 85.0, 84.0, 90.0, 85.0, 88.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 151.0, 151.0, 173.0, 161.0, 148.0, 142.0, 222.0, 299.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 173.0, 170.0, 173.0, 169.0, 173.0, 170.0, 173.0, 172.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 68.0, 69.0, 67.0, 70.0, 68.0, 66.0, 71.0], "value": 68.5, "unit": "score"}]}]} 10:55:28 INFO - Return code: 0 10:55:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:55:28 ERROR - # TBPL SUCCESS # 10:55:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:28 INFO - 2016-11-29 10:55:28.829 screenresolution[1668:10604] starting screenresolution argv=screenresolution get 10:55:28 INFO - 2016-11-29 10:55:28.834 screenresolution[1668:10604] Display 0: 1600x1200x32@60 10:55:28 INFO - 2016-11-29 10:55:28.840 screenresolution[1669:10607] starting screenresolution argv=screenresolution list 10:55:28 INFO - Available Modes on Display 0 10:55:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:29 INFO - Intel Iris: 10:55:29 INFO - Chipset Model: Intel Iris 10:55:29 INFO - Type: GPU 10:55:29 INFO - Bus: Built-In 10:55:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:29 INFO - Vendor: Intel (0x8086) 10:55:29 INFO - Device ID: 0x0a2e 10:55:29 INFO - Revision ID: 0x0009 10:55:29 INFO - Displays: 10:55:29 INFO - Display: 10:55:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:29 INFO - Display Serial Number: 1600x1200 60 10:55:29 INFO - Main Display: Yes 10:55:29 INFO - Mirror: Off 10:55:29 INFO - Online: Yes 10:55:29 INFO - Rotation: Supported 10:55:29 INFO - Return code: 0 10:55:29 INFO - Running post-action listener: _resource_record_post_action 10:55:29 INFO - [mozharness: 2016-11-29 18:55:29.076845Z] Finished run-tests step (success) 10:55:29 INFO - Running post-run listener: _resource_record_post_run 10:55:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38664704; Write bytes: 655506432; Read time: 244; Write time: 1888 10:55:29 INFO - TinderboxPrint: CPU usage
54.1% 10:55:29 INFO - TinderboxPrint: I/O read bytes / time
38,664,704 / 244 10:55:29 INFO - TinderboxPrint: I/O write bytes / time
655,506,432 / 1,888 10:55:29 INFO - TinderboxPrint: CPU idle
2,220.5 (45.9%) 10:55:29 INFO - TinderboxPrint: CPU system
975.0 (20.1%) 10:55:29 INFO - TinderboxPrint: CPU user
1,646.2 (34.0%) 10:55:29 INFO - TinderboxPrint: Swap in / out
386,715,648 / 0 10:55:29 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 344578560; Write bytes: 344512512; Read time: 26799; Write time: 701 10:55:29 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36690432; Write bytes: 304014336; Read time: 228; Write time: 1158 10:55:29 INFO - Running post-run listener: _upload_blobber_files 10:55:29 INFO - Blob upload gear active. 10:55:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:55:29 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 10:55:29 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'] 10:55:29 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 10:55:29 INFO - (blobuploader) - INFO - Open directory for files ... 10:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:30 INFO - (blobuploader) - INFO - Done attempting. 10:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:31 INFO - (blobuploader) - INFO - Done attempting. 10:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:55:34 INFO - (blobuploader) - INFO - Done attempting. 10:55:34 INFO - (blobuploader) - INFO - Iteration through files over. 10:55:34 INFO - Return code: 0 10:55:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:55:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:55:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285e2e26f3df1df4ca2c6573751342b56e8050217e98745750ef6b11ac0de1c140e589cdb4539c15f8bd7d9b11e57308776ab13ddb225c37c96ad6fc51cff7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2070f0c96dd99aa74067d554f5eb5c863b31e22d3e64a980e01abdca230d1da7d98b704aed316f012cf65db9be41da7860fdf1a7cbd5962340d82d4f44f8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c2629a4397e930d8781f3b8d289ab14b5795e138d56803474c394fb2757883f84c2c5eb6a028103e95acc07ddb687297f7c34fc0e29c2c79c81f203fd21f55"} 10:55:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:55:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:55:34 INFO - Contents: 10:55:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/285e2e26f3df1df4ca2c6573751342b56e8050217e98745750ef6b11ac0de1c140e589cdb4539c15f8bd7d9b11e57308776ab13ddb225c37c96ad6fc51cff7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2070f0c96dd99aa74067d554f5eb5c863b31e22d3e64a980e01abdca230d1da7d98b704aed316f012cf65db9be41da7860fdf1a7cbd5962340d82d4f44f8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c2629a4397e930d8781f3b8d289ab14b5795e138d56803474c394fb2757883f84c2c5eb6a028103e95acc07ddb687297f7c34fc0e29c2c79c81f203fd21f55"} 10:55:34 INFO - Running post-run listener: copy_logs_to_upload_dir 10:55:34 INFO - Copying logs to upload dir... 10:55:34 INFO - mkdir: /builds/slave/test/build/upload/logs 10:55:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.700795 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-29 10:55:34.936359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:55:34.940017) ========= 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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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/285e2e26f3df1df4ca2c6573751342b56e8050217e98745750ef6b11ac0de1c140e589cdb4539c15f8bd7d9b11e57308776ab13ddb225c37c96ad6fc51cff7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2070f0c96dd99aa74067d554f5eb5c863b31e22d3e64a980e01abdca230d1da7d98b704aed316f012cf65db9be41da7860fdf1a7cbd5962340d82d4f44f8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c2629a4397e930d8781f3b8d289ab14b5795e138d56803474c394fb2757883f84c2c5eb6a028103e95acc07ddb687297f7c34fc0e29c2c79c81f203fd21f55"} build_url:https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/QPjpNCjLR-KRpBlXopjtZA/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/285e2e26f3df1df4ca2c6573751342b56e8050217e98745750ef6b11ac0de1c140e589cdb4539c15f8bd7d9b11e57308776ab13ddb225c37c96ad6fc51cff7ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2070f0c96dd99aa74067d554f5eb5c863b31e22d3e64a980e01abdca230d1da7d98b704aed316f012cf65db9be41da7860fdf1a7cbd5962340d82d4f44f8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8c2629a4397e930d8781f3b8d289ab14b5795e138d56803474c394fb2757883f84c2c5eb6a028103e95acc07ddb687297f7c34fc0e29c2c79c81f203fd21f55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 10:55:34.973804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:55:34.974129) ========= 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.hV3s3sAUZD/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.ORQmhAbZTg/Listeners TMPDIR=/var/folders/xd/brxx9n092_bcwjxpfyv8f64c00000w/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.005114 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 10:55:35.128518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:55:35.128847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 10:55:35.129366) ========= ========= Total master_lag: 0.28 =========