builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0235 starttime: 1484565135.39 results: success (0) buildid: 20170116001122 builduid: b6f5d519a59942648b5a213ff916e68e revision: d506e0d4d610a7c982aa71fbe28ade712ccdecdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:15.390761) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:15.391339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:15.391619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:15.445978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:15.446265) ========= 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.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 --2017-01-16 03:12:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-16 03:12:16 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.649000 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:16.119297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:16.119596) ========= 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.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.024741 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:16.167431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 03:12:16.167751) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d506e0d4d610a7c982aa71fbe28ade712ccdecdf --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 d506e0d4d610a7c982aa71fbe28ade712ccdecdf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 2017-01-16 03:12:16,265 truncating revision to first 12 chars 2017-01-16 03:12:16,265 Setting DEBUG logging. 2017-01-16 03:12:16,265 attempt 1/10 2017-01-16 03:12:16,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d506e0d4d610?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 03:12:17,071 unpacking tar archive at: mozilla-aurora-d506e0d4d610/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 03:12:17.278578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:17.278857) ========= script_repo_revision: d506e0d4d610a7c982aa71fbe28ade712ccdecdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:17.279247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:17.279519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 03:12:17.299205) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-16 03:12:17.299489) ========= /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.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:12:17 INFO - MultiFileLogger online at 20170116 03:12:17 in /builds/slave/test 03:12:17 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 03:12:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:17 INFO - {'append_to_log': False, 03:12:17 INFO - 'base_work_dir': '/builds/slave/test', 03:12:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:17 INFO - 'branch': 'Mozilla-Aurora', 03:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:17 INFO - 'config_files': ('talos/mac_config.py',), 03:12:17 INFO - 'default_actions': ('clobber', 03:12:17 INFO - 'read-buildbot-config', 03:12:17 INFO - 'download-and-extract', 03:12:17 INFO - 'populate-webroot', 03:12:17 INFO - 'create-virtualenv', 03:12:17 INFO - 'install', 03:12:17 INFO - 'run-tests'), 03:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:17 INFO - 'download_minidump_stackwalk': True, 03:12:17 INFO - 'download_symbols': 'ondemand', 03:12:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:17 INFO - 'installer_path': 'installer.exe', 03:12:17 INFO - 'log_level': 'info', 03:12:17 INFO - 'log_name': 'talos', 03:12:17 INFO - 'log_to_console': True, 03:12:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:12:17 INFO - 'opt_config_files': (), 03:12:17 INFO - 'pip_index': False, 03:12:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:17 INFO - 'cmd': ('bash', 03:12:17 INFO - '-c', 03:12:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:17 INFO - 'enabled': True, 03:12:17 INFO - 'halt_on_failure': False, 03:12:17 INFO - 'name': 'check_screen_resolution'},), 03:12:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:17 INFO - 'cmd': ('bash', 03:12:17 INFO - '-c', 03:12:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:17 INFO - 'enabled': True, 03:12:17 INFO - 'halt_on_failure': False, 03:12:17 INFO - 'name': 'check_screen_resolution'},), 03:12:17 INFO - 'run_cmd_checks_enabled': True, 03:12:17 INFO - 'sps_profile': False, 03:12:17 INFO - 'sps_profile_interval': 0, 03:12:17 INFO - 'suite': 'dromaeojs-e10s', 03:12:17 INFO - 'system_bits': '32', 03:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:17 INFO - 'title': 't-yosemite-r7-0235', 03:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:17 INFO - 'use_talos_json': True, 03:12:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:17 INFO - 'work_dir': 'build'} 03:12:17 INFO - [mozharness: 2017-01-16 11:12:17.498244Z] Running clobber step. 03:12:17 INFO - Running pre-action listener: _resource_record_pre_action 03:12:17 INFO - Running main action method: clobber 03:12:17 INFO - rmtree: /builds/slave/test/build 03:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:19 INFO - Running post-action listener: _resource_record_post_action 03:12:19 INFO - [mozharness: 2017-01-16 11:12:19.773272Z] Finished clobber step (success) 03:12:19 INFO - [mozharness: 2017-01-16 11:12:19.773409Z] Running read-buildbot-config step. 03:12:19 INFO - Running pre-action listener: _resource_record_pre_action 03:12:19 INFO - Running main action method: read_buildbot_config 03:12:19 INFO - Using buildbot properties: 03:12:19 INFO - { 03:12:19 INFO - "project": "", 03:12:19 INFO - "product": "firefox", 03:12:19 INFO - "script_repo_revision": "production", 03:12:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:12:19 INFO - "repository": "", 03:12:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:12:19 INFO - "buildid": "20170116001122", 03:12:19 INFO - "pgo_build": "False", 03:12:19 INFO - "basedir": "/builds/slave/test", 03:12:19 INFO - "buildnumber": 16, 03:12:19 INFO - "slavename": "t-yosemite-r7-0235", 03:12:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:12:19 INFO - "platform": "yosemite_r7", 03:12:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:12:19 INFO - "branch": "mozilla-aurora", 03:12:19 INFO - "repo_path": "releases/mozilla-aurora", 03:12:19 INFO - "revision": "d506e0d4d610a7c982aa71fbe28ade712ccdecdf", 03:12:19 INFO - "stage_platform": "macosx64", 03:12:19 INFO - "builduid": "b6f5d519a59942648b5a213ff916e68e", 03:12:19 INFO - "slavebuilddir": "test" 03:12:19 INFO - } 03:12:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:12:19 INFO - Running post-action listener: _resource_record_post_action 03:12:19 INFO - [mozharness: 2017-01-16 11:12:19.776852Z] Finished read-buildbot-config step (success) 03:12:19 INFO - [mozharness: 2017-01-16 11:12:19.776992Z] Running download-and-extract step. 03:12:19 INFO - Running pre-action listener: _resource_record_pre_action 03:12:19 INFO - Running main action method: download_and_extract 03:12:19 INFO - mkdir: /builds/slave/test/build/tests 03:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:19 INFO - trying https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:12:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/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 03:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/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 03:12:20 INFO - Downloaded 1199 bytes. 03:12:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:12:20 INFO - Using the following test package requirements: 03:12:20 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:12:20 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:12:20 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:12:20 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'jsshell-mac.zip'], 03:12:20 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:12:20 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:12:20 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:12:20 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:12:20 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:12:20 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:12:20 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:12:20 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:12:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:12:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:12:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:12:21 INFO - Http code: 200 03:12:21 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 03:12:21 INFO - x-amz-cf-id: 0Cc1zKJ8H0tkp3BwokscvQUmtyGtrgVgi9AJ-DxiksYTZ7Cn_uOnNQ== 03:12:21 INFO - x-amz-version-id: 38mxJzjcVUtMDtH8oxC3kaCI.5jEpMM2 03:12:21 INFO - Expected file size: 16275925 03:12:21 INFO - Obtained file size: 16275925 03:12:28 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 03:12:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:12:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:12:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:12:28 INFO - Http code: 200 03:12:28 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 03:12:28 INFO - x-amz-cf-id: Y2jSMTEmBbQeY8QVb4og4F6BJknr_3rqAHflaksqU09D-_SlCHAAag== 03:12:28 INFO - x-amz-version-id: 38mxJzjcVUtMDtH8oxC3kaCI.5jEpMM2 03:12:28 INFO - Expected file size: 16275925 03:12:28 INFO - Obtained file size: 16275925 03:12:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:12:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:12:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:12:36 INFO - Http code: 200 03:12:36 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 03:12:36 INFO - x-amz-cf-id: 58TohB_RlhqyayMM0zMXqAnQMcLLlYkeYO2lCbuNQqrpILUXPd7_9w== 03:12:36 INFO - x-amz-version-id: KOqzyF0P95gBHr1NQhnvk8QhZrdXcmoN 03:12:36 INFO - Expected file size: 14409038 03:12:36 INFO - Obtained file size: 14409038 03:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:36 INFO - trying https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:12:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/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 03:12:39 INFO - Downloaded 110005149 bytes. 03:12:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:12:39 INFO - mkdir: /builds/slave/test/properties 03:12:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:12:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:12:39 INFO - Contents: 03:12:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:12:40 INFO - Running post-action listener: _resource_record_post_action 03:12:40 INFO - Running post-action listener: set_extra_try_arguments 03:12:40 INFO - [mozharness: 2017-01-16 11:12:40.849394Z] Finished download-and-extract step (success) 03:12:40 INFO - [mozharness: 2017-01-16 11:12:40.849530Z] Running populate-webroot step. 03:12:40 INFO - Running pre-action listener: _resource_record_pre_action 03:12:40 INFO - Running main action method: populate_webroot 03:12:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:12:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:12:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:12:40 INFO - '--tppagecycles', 03:12:40 INFO - '7'], 03:12:40 INFO - 'tests': ['tsvgm']}}, 03:12:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:12:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:12:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:12:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:12:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['damp', 'tps']}, 03:12:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'tests': ['damp', 'tps']}, 03:12:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['dromaeo_dom']}, 03:12:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:12:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['basic_compositor_video']}, 03:12:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:12:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['a11yr', 03:12:40 INFO - 'ts_paint', 03:12:40 INFO - 'tpaint', 03:12:40 INFO - 'sessionrestore', 03:12:40 INFO - 'sessionrestore_no_auto_restore', 03:12:40 INFO - 'tabpaint']}, 03:12:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['tsvgx', 03:12:40 INFO - 'tsvgr_opacity', 03:12:40 INFO - 'tart', 03:12:40 INFO - 'tscrollx', 03:12:40 INFO - 'cart']}, 03:12:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:12:40 INFO - 'tsvgr_opacity', 03:12:40 INFO - 'tart', 03:12:40 INFO - 'tscrollx', 03:12:40 INFO - 'cart']}, 03:12:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'talos_options': ['--disable-e10s'], 03:12:40 INFO - 'tests': ['tp5o']}, 03:12:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'tests': ['tp5o']}, 03:12:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'talos_options': ['--disable-e10s', 03:12:40 INFO - '--xperf_path', 03:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:40 INFO - 'tests': ['tp5n']}, 03:12:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:40 INFO - 'talos_options': ['--xperf_path', 03:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:40 INFO - 'tests': ['tp5n']}}, 03:12:40 INFO - 'talos.zip': {'path': '', 03:12:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:12:40 INFO - Running post-action listener: _resource_record_post_action 03:12:40 INFO - [mozharness: 2017-01-16 11:12:40.868300Z] Finished populate-webroot step (success) 03:12:40 INFO - [mozharness: 2017-01-16 11:12:40.868437Z] Running create-virtualenv step. 03:12:40 INFO - Running pre-action listener: _resource_record_pre_action 03:12:40 INFO - Running main action method: create_virtualenv 03:12:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:12:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:12:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:12:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:12:40 INFO - Using real prefix '/tools/python27' 03:12:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:12:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:12:44 INFO - Installing pip.................done. 03:12:44 INFO - Return code: 0 03:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:12:44 INFO - Reading from file tmpfile_stdout 03:12:44 INFO - Output received: 03:12:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:12:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:12:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:44 INFO - 'HOME': '/Users/cltbld', 03:12:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:44 INFO - 'LOGNAME': 'cltbld', 03:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:44 INFO - 'MOZ_NO_REMOTE': '1', 03:12:44 INFO - 'NO_EM_RESTART': '1', 03:12:44 INFO - 'PAGER': '/bin/cat', 03:12:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:44 INFO - 'PWD': '/builds/slave/test', 03:12:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:44 INFO - 'SHELL': '/bin/bash', 03:12:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:44 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:44 INFO - 'USER': 'cltbld', 03:12:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:44 INFO - 'XPC_FLAGS': '0x0', 03:12:44 INFO - 'XPC_SERVICE_NAME': '0', 03:12:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:12:45 INFO - Cleaning up... 03:12:45 INFO - Return code: 0 03:12:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:45 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:45 INFO - 'HOME': '/Users/cltbld', 03:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:45 INFO - 'LOGNAME': 'cltbld', 03:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:45 INFO - 'MOZ_NO_REMOTE': '1', 03:12:45 INFO - 'NO_EM_RESTART': '1', 03:12:45 INFO - 'PAGER': '/bin/cat', 03:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:45 INFO - 'PWD': '/builds/slave/test', 03:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:45 INFO - 'SHELL': '/bin/bash', 03:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:45 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:45 INFO - 'USER': 'cltbld', 03:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:45 INFO - 'XPC_FLAGS': '0x0', 03:12:45 INFO - 'XPC_SERVICE_NAME': '0', 03:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:45 INFO - Downloading/unpacking psutil>=3.1.1 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:12:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:49 INFO - Installing collected packages: psutil 03:12:49 INFO - Running setup.py install for psutil 03:12:49 INFO - building 'psutil._psutil_osx' extension 03:12:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:12:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:12:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:12:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:12:49 INFO - building 'psutil._psutil_posix' extension 03:12:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:12:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:12:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:12:50 INFO - ^ 03:12:50 INFO - 1 warning generated. 03:12:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:12:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:50 INFO - Successfully installed psutil 03:12:50 INFO - Cleaning up... 03:12:50 INFO - Return code: 0 03:12:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:12: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 mozsystemmonitor==0.3 03:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:50 INFO - 'HOME': '/Users/cltbld', 03:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:50 INFO - 'LOGNAME': 'cltbld', 03:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:50 INFO - 'MOZ_NO_REMOTE': '1', 03:12:50 INFO - 'NO_EM_RESTART': '1', 03:12:50 INFO - 'PAGER': '/bin/cat', 03:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:50 INFO - 'PWD': '/builds/slave/test', 03:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:50 INFO - 'SHELL': '/bin/bash', 03:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:50 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:50 INFO - 'USER': 'cltbld', 03:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:50 INFO - 'XPC_FLAGS': '0x0', 03:12:50 INFO - 'XPC_SERVICE_NAME': '0', 03:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12: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 03:12:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:12:53 INFO - Installing collected packages: mozsystemmonitor 03:12:53 INFO - Running setup.py install for mozsystemmonitor 03:12:53 INFO - Successfully installed mozsystemmonitor 03:12:53 INFO - Cleaning up... 03:12:53 INFO - Return code: 0 03:12:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:53 INFO - 'HOME': '/Users/cltbld', 03:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:53 INFO - 'LOGNAME': 'cltbld', 03:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:53 INFO - 'MOZ_NO_REMOTE': '1', 03:12:53 INFO - 'NO_EM_RESTART': '1', 03:12:53 INFO - 'PAGER': '/bin/cat', 03:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:53 INFO - 'PWD': '/builds/slave/test', 03:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:53 INFO - 'SHELL': '/bin/bash', 03:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:53 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:53 INFO - 'USER': 'cltbld', 03:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:53 INFO - 'XPC_FLAGS': '0x0', 03:12:53 INFO - 'XPC_SERVICE_NAME': '0', 03:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:56 INFO - warning: no files found matching '*.txt' 03:12:56 INFO - no previously-included directories found matching 'build' 03:12:56 INFO - no previously-included directories found matching 'dist' 03:12:56 INFO - no previously-included directories found matching '.git*' 03:12:56 INFO - Installing collected packages: jsonschema, functools32 03:12:56 INFO - Running setup.py install for functools32 03:12:56 INFO - warning: no files found matching '*.txt' 03:12:56 INFO - no previously-included directories found matching 'build' 03:12:56 INFO - no previously-included directories found matching 'dist' 03:12:56 INFO - no previously-included directories found matching '.git*' 03:12:56 INFO - Successfully installed jsonschema functools32 03:12:56 INFO - Cleaning up... 03:12:57 INFO - Return code: 0 03:12:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:57 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:57 INFO - 'HOME': '/Users/cltbld', 03:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:57 INFO - 'LOGNAME': 'cltbld', 03:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:57 INFO - 'MOZ_NO_REMOTE': '1', 03:12:57 INFO - 'NO_EM_RESTART': '1', 03:12:57 INFO - 'PAGER': '/bin/cat', 03:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:57 INFO - 'PWD': '/builds/slave/test', 03:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:57 INFO - 'SHELL': '/bin/bash', 03:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:57 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:57 INFO - 'USER': 'cltbld', 03:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:57 INFO - 'XPC_FLAGS': '0x0', 03:12:57 INFO - 'XPC_SERVICE_NAME': '0', 03:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:12:57 INFO - Cleaning up... 03:12:57 INFO - Return code: 0 03:12:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:57 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:57 INFO - 'HOME': '/Users/cltbld', 03:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:57 INFO - 'LOGNAME': 'cltbld', 03:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:57 INFO - 'MOZ_NO_REMOTE': '1', 03:12:57 INFO - 'NO_EM_RESTART': '1', 03:12:57 INFO - 'PAGER': '/bin/cat', 03:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:57 INFO - 'PWD': '/builds/slave/test', 03:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:57 INFO - 'SHELL': '/bin/bash', 03:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:12:57 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:57 INFO - 'USER': 'cltbld', 03:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:57 INFO - 'XPC_FLAGS': '0x0', 03:12:57 INFO - 'XPC_SERVICE_NAME': '0', 03:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:01 INFO - Downloading docopt-0.6.1.tar.gz 03:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:01 INFO - Running setup.py install for blobuploader 03:13:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:01 INFO - Running setup.py install for requests 03:13:02 INFO - Running setup.py install for docopt 03:13:02 INFO - Successfully installed blobuploader requests docopt 03:13:02 INFO - Cleaning up... 03:13:02 INFO - Return code: 0 03:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:02 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:02 INFO - 'HOME': '/Users/cltbld', 03:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:02 INFO - 'LOGNAME': 'cltbld', 03:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:02 INFO - 'MOZ_NO_REMOTE': '1', 03:13:02 INFO - 'NO_EM_RESTART': '1', 03:13:02 INFO - 'PAGER': '/bin/cat', 03:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:02 INFO - 'PWD': '/builds/slave/test', 03:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:02 INFO - 'SHELL': '/bin/bash', 03:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:13:02 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:02 INFO - 'USER': 'cltbld', 03:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:02 INFO - 'XPC_FLAGS': '0x0', 03:13:02 INFO - 'XPC_SERVICE_NAME': '0', 03:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:02 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mcEn1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:02 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-J0kqKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:02 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-iYhD7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:02 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oPUyz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-X7ZAjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BEB8pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-c8p_eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-U39P5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CjT8xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Up6qUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-S0bHJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KgQUyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:03 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Fv2iJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:04 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Tgpz89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:04 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-R4_Htl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:04 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-FP_Kl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:04 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hplbKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:04 INFO - Running setup.py install for manifestparser 03:13:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:04 INFO - Running setup.py install for mozcrash 03:13:04 INFO - Running setup.py install for mozdebug 03:13:04 INFO - Running setup.py install for mozdevice 03:13:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Running setup.py install for mozfile 03:13:05 INFO - Running setup.py install for mozhttpd 03:13:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Running setup.py install for mozinfo 03:13:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Running setup.py install for mozInstall 03:13:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Running setup.py install for mozleak 03:13:05 INFO - Running setup.py install for mozlog 03:13:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:05 INFO - Running setup.py install for moznetwork 03:13:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Running setup.py install for mozprocess 03:13:06 INFO - Running setup.py install for mozprofile 03:13:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Running setup.py install for mozrunner 03:13:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Running setup.py install for mozscreenshot 03:13:06 INFO - Running setup.py install for moztest 03:13:06 INFO - Running setup.py install for mozversion 03:13:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:06 INFO - Cleaning up... 03:13:07 INFO - Return code: 0 03:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:07 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:07 INFO - 'HOME': '/Users/cltbld', 03:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:07 INFO - 'LOGNAME': 'cltbld', 03:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:07 INFO - 'MOZ_NO_REMOTE': '1', 03:13:07 INFO - 'NO_EM_RESTART': '1', 03:13:07 INFO - 'PAGER': '/bin/cat', 03:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:07 INFO - 'PWD': '/builds/slave/test', 03:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:07 INFO - 'SHELL': '/bin/bash', 03:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:13:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:07 INFO - 'USER': 'cltbld', 03:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:07 INFO - 'XPC_FLAGS': '0x0', 03:13:07 INFO - 'XPC_SERVICE_NAME': '0', 03:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SEQhE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6qL1fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:07 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)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-K_F7zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-3dDLvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-7J5enF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Zkrdjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:07 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tg3FpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-i5WEdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-GubWoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-G94nop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-pFRDHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-cfRaZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ujHf2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-F8vYLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:08 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)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oU07N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-pNKluI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:08 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-I49pEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:13:09 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)) 03:13:09 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)) 03:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:11 INFO - Downloading blessings-1.6.tar.gz 03:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:11 INFO - Installing collected packages: blessings 03:13:11 INFO - Running setup.py install for blessings 03:13:11 INFO - Successfully installed blessings 03:13:11 INFO - Cleaning up... 03:13:12 INFO - Return code: 0 03:13:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:12 INFO - Reading from file tmpfile_stdout 03:13:12 INFO - Current package versions: 03:13:12 INFO - blessings == 1.6 03:13:12 INFO - blobuploader == 1.2.4 03:13:12 INFO - docopt == 0.6.1 03:13:12 INFO - functools32 == 3.2.3-2 03:13:12 INFO - jsonschema == 2.5.1 03:13:12 INFO - manifestparser == 1.1 03:13:12 INFO - mozInstall == 1.12 03:13:12 INFO - mozcrash == 1.0 03:13:12 INFO - mozdebug == 0.1 03:13:12 INFO - mozdevice == 0.48 03:13:12 INFO - mozfile == 1.2 03:13:12 INFO - mozhttpd == 0.7 03:13:12 INFO - mozinfo == 0.9 03:13:12 INFO - mozleak == 0.1 03:13:12 INFO - mozlog == 3.4 03:13:12 INFO - moznetwork == 0.27 03:13:12 INFO - mozprocess == 0.23 03:13:12 INFO - mozprofile == 0.28 03:13:12 INFO - mozrunner == 6.13 03:13:12 INFO - mozscreenshot == 0.1 03:13:12 INFO - mozsystemmonitor == 0.3 03:13:12 INFO - moztest == 0.8 03:13:12 INFO - mozversion == 1.4 03:13:12 INFO - psutil == 3.1.1 03:13:12 INFO - requests == 1.2.3 03:13:12 INFO - wsgiref == 0.1.2 03:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:12 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:12 INFO - 'HOME': '/Users/cltbld', 03:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:12 INFO - 'LOGNAME': 'cltbld', 03:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:12 INFO - 'MOZ_NO_REMOTE': '1', 03:13:12 INFO - 'NO_EM_RESTART': '1', 03:13:12 INFO - 'PAGER': '/bin/cat', 03:13:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:12 INFO - 'PWD': '/builds/slave/test', 03:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:12 INFO - 'SHELL': '/bin/bash', 03:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:13:12 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:12 INFO - 'USER': 'cltbld', 03:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:12 INFO - 'XPC_FLAGS': '0x0', 03:13:12 INFO - 'XPC_SERVICE_NAME': '0', 03:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:12 INFO - Cleaning up... 03:13:12 INFO - Return code: 0 03:13:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:12 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 0x100837490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3b04393c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, '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.VyOb9M91MF/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.MFRdz6kMsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:12 INFO - 'HOME': '/Users/cltbld', 03:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:12 INFO - 'LOGNAME': 'cltbld', 03:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:12 INFO - 'MOZ_NO_REMOTE': '1', 03:13:12 INFO - 'NO_EM_RESTART': '1', 03:13:12 INFO - 'PAGER': '/bin/cat', 03:13:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:12 INFO - 'PWD': '/builds/slave/test', 03:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:12 INFO - 'SHELL': '/bin/bash', 03:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:13:12 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:12 INFO - 'USER': 'cltbld', 03:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:12 INFO - 'XPC_FLAGS': '0x0', 03:13:12 INFO - 'XPC_SERVICE_NAME': '0', 03:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:12 INFO - Cleaning up... 03:13:12 INFO - Return code: 0 03:13:12 INFO - Running post-action listener: _resource_record_post_action 03:13:12 INFO - Running post-action listener: _start_resource_monitoring 03:13:12 INFO - Starting resource monitoring. 03:13:12 INFO - [mozharness: 2017-01-16 11:13:12.927199Z] Finished create-virtualenv step (success) 03:13:12 INFO - [mozharness: 2017-01-16 11:13:12.928182Z] Running install step. 03:13:12 INFO - Running pre-action listener: _resource_record_pre_action 03:13:12 INFO - Running main action method: install 03:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:13 INFO - Reading from file tmpfile_stdout 03:13:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:13 INFO - Reading from file tmpfile_stdout 03:13:13 INFO - Output received: 03:13:13 INFO - Usage: mozinstall [options] installer 03:13:13 INFO - Options: 03:13:13 INFO - -h, --help show this help message and exit 03:13:13 INFO - -d DEST, --destination=DEST 03:13:13 INFO - Directory to install application into. [default: 03:13:13 INFO - "/builds/slave/test"] 03:13:13 INFO - --app=APP Application being installed. [default: firefox] 03:13:13 INFO - mkdir: /builds/slave/test/build/application 03:13:13 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'] 03:13:13 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 03:13:44 INFO - Reading from file tmpfile_stdout 03:13:44 INFO - Output received: 03:13:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:13:44 INFO - Running post-action listener: _resource_record_post_action 03:13:44 INFO - [mozharness: 2017-01-16 11:13:44.273874Z] Finished install step (success) 03:13:44 INFO - [mozharness: 2017-01-16 11:13:44.274034Z] Running run-tests step. 03:13:44 INFO - Running pre-action listener: _resource_record_pre_action 03:13:44 INFO - Running main action method: run_tests 03:13:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:44 INFO - 2017-01-16 03:13:44.288 screenresolution[1679:7872] starting screenresolution argv=screenresolution get 03:13:44 INFO - 2017-01-16 03:13:44.290 screenresolution[1679:7872] Display 0: 1600x1200x32@60 03:13:44 INFO - 2017-01-16 03:13:44.296 screenresolution[1680:7874] starting screenresolution argv=screenresolution list 03:13:44 INFO - Available Modes on Display 0 03:13:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:44 INFO - Intel Iris: 03:13:44 INFO - Chipset Model: Intel Iris 03:13:44 INFO - Type: GPU 03:13:44 INFO - Bus: Built-In 03:13:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:44 INFO - Vendor: Intel (0x8086) 03:13:44 INFO - Device ID: 0x0a2e 03:13:44 INFO - Revision ID: 0x0009 03:13:44 INFO - Displays: 03:13:44 INFO - Display: 03:13:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:44 INFO - Display Serial Number: 1600x1200 60 03:13:44 INFO - Main Display: Yes 03:13:44 INFO - Mirror: Off 03:13:44 INFO - Online: Yes 03:13:44 INFO - Rotation: Supported 03:13:44 INFO - Return code: 0 03:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:44 INFO - Python 2.7.3 03:13:44 INFO - Return code: 0 03:13:44 INFO - grabbing minidump binary from tooltool 03:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:44 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 0x10064bd30>, '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 0x1004b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100643b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:13:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:13:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:13:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:44 INFO - Return code: 0 03:13:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:13:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:13:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:44 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/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:13:44 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/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VyOb9M91MF/Render', 03:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:44 INFO - 'HOME': '/Users/cltbld', 03:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:44 INFO - 'LOGNAME': 'cltbld', 03:13:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:44 INFO - 'MOZ_NO_REMOTE': '1', 03:13:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:44 INFO - 'NO_EM_RESTART': '1', 03:13:44 INFO - 'PAGER': '/bin/cat', 03:13:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:44 INFO - 'PWD': '/builds/slave/test', 03:13:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:44 INFO - 'SHELL': '/bin/bash', 03:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MFRdz6kMsB/Listeners', 03:13:44 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 03:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:44 INFO - 'USER': 'cltbld', 03:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:44 INFO - 'XPC_FLAGS': '0x0', 03:13:44 INFO - 'XPC_SERVICE_NAME': '0', 03:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:44 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/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:13:44 INFO - mozversion application_buildid: 20170116001122 03:13:44 INFO - mozversion application_changeset: d506e0d4d610a7c982aa71fbe28ade712ccdecdf 03:13:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:13:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:44 INFO - mozversion application_name: Firefox 03:13:44 INFO - mozversion application_remotingname: firefox-dev 03:13:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:13:44 INFO - mozversion application_vendor: Mozilla 03:13:44 INFO - mozversion application_version: 52.0a2 03:13:44 INFO - mozversion platform_buildid: 20170116001122 03:13:44 INFO - mozversion platform_changeset: d506e0d4d610a7c982aa71fbe28ade712ccdecdf 03:13:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:13:44 INFO - mozversion platform_version: 52.0a2 03:13:44 INFO - using testdate: 1484565224 03:13:44 INFO - actual date: 1484565224 03:13:44 INFO - starting webserver on 'localhost:49236' 03:13:44 INFO - SUITE-START | Running 2 tests 03:13:44 INFO - TEST-START | dromaeo_css 03:13:44 INFO - operating with platform_type : mac_ 03:13:44 INFO - Initialising browser for dromaeo_css test... 03:13:44 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp_93dQG/profile http://localhost:49236/getInfo.html) 03:13:48 INFO - PROCESS | 1690 | 2017-01-16 03:13:48.038 plugin-container[1692:8061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3b, name = 'com.apple.tsm.portname' 03:13:48 INFO - PROCESS | 1690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:13:48 INFO - PROCESS | 1690 | 2017-01-16 03:13:48.041 plugin-container[1692:8061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x490f, name = 'com.apple.CFPasteboardClient' 03:13:48 INFO - PROCESS | 1690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:13:48 INFO - PROCESS | 1690 | 2017-01-16 03:13:48.041 plugin-container[1692:8061] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:13:48 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 03:13:48 INFO - PROCESS | 1690 | colorDepth:24 03:13:48 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 03:13:48 INFO - PROCESS | 1690 | __metrics 03:13:48 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 03:13:49 INFO - TEST-INFO | 1690: exit 0 03:13:49 INFO - Browser initialized. 03:13:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:13:49 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp_93dQG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:51 INFO - PROCESS | 1694 | 2017-01-16 03:13:51.726 plugin-container[1695:8193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8637, name = 'com.apple.tsm.portname' 03:13:51 INFO - PROCESS | 1694 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:13:51 INFO - PROCESS | 1694 | 2017-01-16 03:13:51.727 plugin-container[1695:8193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 03:13:51 INFO - PROCESS | 1694 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:13:51 INFO - PROCESS | 1694 | 2017-01-16 03:13:51.727 plugin-container[1695:8193] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:14:01 INFO - PROCESS | 1694 | RSS: Main: 229224448 03:14:01 INFO - PROCESS | 1694 | 03:17:03 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 03:17:05 INFO - PROCESS | 1694 | RSS: Main: 235642880 03:17:05 INFO - PROCESS | 1694 | 03:20:07 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 03:20:08 INFO - PROCESS | 1694 | RSS: Main: 243556352 03:20:08 INFO - PROCESS | 1694 | 03:23:10 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 03:23:10 INFO - PROCESS | 1694 | RSS: Main: 247640064 03:23:10 INFO - PROCESS | 1694 | 03:26:12 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 03:26:13 INFO - PROCESS | 1694 | RSS: Main: 246808576 03:26:13 INFO - PROCESS | 1694 | 03:29:16 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 03:29:17 INFO - PROCESS | 1694 | RSS: Main: 250355712 03:29:17 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 03:32:19 INFO - PROCESS | 1694 | RSS: Main: 252497920 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | __start_tp_report 03:32:19 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 03:32:19 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 03:32:19 INFO - PROCESS | 1694 | |i|pagename|runs| 03:32:19 INFO - PROCESS | 1694 | |0;dojo.html;2637.3274814922197;3396.167938854979;3414.6073201581826;3421.247325588371;3442.156671615455;5803.187553742474;5824.475797178253;5867.55993300502;5933.288005439343;5986.221791167142;5903.586748927577;5947.732352044158;5965.164876917235;5987.5509336799805;5988.910166347498;4174.561671024544;5328.307320048389;5390.245365648812;5395.433479484656;5424.674519528841;4734.455537613167;5425.538829199503;5427.972860135694;5462.481064298885;5489.725513724317;5285.920711189336;5300.946990530103;5450.182472629118;5467.152591348327;5470;5340.225667278261;5344.144936810111;5373.785048598052;5452.482014208684;5477.726113694339;5265.736713164327;5379.435159308256;5387.946120538783;5397.8380648580605;5452.1276595744885;5730.82807515771;5974.103884417372;6035.366286539938;6074.939250607482;6092.847678808021;6244.718987645567;6262.2798378186635;6265.122882796367;6292.5595208335435;6316.052592111174;6298.49612031041;6327.430531252164;6358.713857876407;6399.680015999182;6407.583507072025;6088.11722300264;6092.786752463687;6094.268687757498;6121.693915304217;6124.142620033199;6360.872782544323;6374.171357723466;6454.128692626436;6493.415592596689;6530.967345163339;6236.937630623726;6329.050642403677;6329.272133704683;6337.904931426032;6347.71435285404;5057.266696329012;6120.203342909657;6349.682515874188;6357.4596159326975;6375.904361434582;6266.467350275278;6291.1192433059405;6301.495880329563;6347.365263473615;6386.521010924199;5363.839084827461;6292.993121100602;6296.150019747367;6316.084167795644;6330.841728956813;5076.238564215323;5084.084864724311;5094.235864620263;5096.898062038738;5100.56645185156;4439.156560253541;4439.889002774957;4441.578050085237;4468.709533880287;4537.6143027843;5908.675022873783;6136.53592945783;6139.631622102688;6140.969295153585;6141.6007959482495;6365.7096192724675;6396.680165991682;6427.58220715652;6433.613983161025;6585.209774827052;5131.538161565402;5977.834322307195;6009.489193418521;6028.577999540078;6081.361457046946;5583.274174357308;5597.832065038056;5607.355154157242;5608.270924779753;5640.520555752725;5411.350637923317;6510.707018184193;6540.542162048611;6556.704948277244;6574.112494813235;6212.161358216583;6264.185655864709;6267.341929097379;6282.026285925689;6397.840053998501;6516.446102081187;6570.671466426755;6586.275509693834;6589.275179730322;6606.43845273138;6256.173855778598;6282.968585157045;6322.810315690536;6352.205974253218;6353.4599559038;5928.110783382527;6177.104319873503;6270.184875966278;6297.4017468340435;6388.041793730978;5172.7413629319135;6259.311475737756;6316.178896743394;6341.0805433212845;6351.2060992375955;6271.62370257786;6298.307186209605;6305.085762564494;6326.33573474797;6327.462165715966;5969.164316995537;6033.517318614413;6086.452219300284;6086.786962456293;6213.5339849510565;6244.469220116341;6274.121622972696;6300.558960872878;6329.968350158219;6352.301246862934;5009.949900500948;5148.279240906351;6169.074638804036;6195.845103872259;6238.532110091852 03:32:19 INFO - PROCESS | 1694 | |1;ext.html;503.68771361755694;516.8475299786563;521.8617066477382;534.3961323704214;547.2994566954297;37557.812210938944;38409;39627.40558891619;39897.60102398975;40000.39999400004;41240.58759412405;41832.581674183246;41979;41989.160216795724;42090.78954605223;8168.224018718242;9214.769630759218;9359.578818953129;9519.048095190461;9525.904740952572;9050.818983620324;9439.575219115157;9510.47692376919;9546.474943878084;9571.712848614517;9536.52317384128;9556.139947404732;9557.856632150524;9568.712938611852;9611.086946740048;9418.764530886714;9468.57391417388;9473;9486.620535178585;9508.952455237748;9402.811943761086;9415.199708024826;9517.381370210915;9528.618855245782;9642.42145471274;39621.20757584832;39713;39940.40089398661;40044.79977600122;40063;3090.8300043497597;3378.4932260160926;3504.4653993913034;3696.685781708558;3717.8141092945516;29349.559756603667;29391.971281005062;30450.54324185139;30775.38449231025;30832.38335233283;3203.6475987641343;3251.3984912790975;3259.3481303739345;3261.706446419834;3328.7350806693303;500932;505793.47103264247;507427;507694.46152769367;509243.4537827324;62208.75582488325;62272.37727622756;62303.6884815573;62384.68807655932;62520;64958;65065;65147;65147.67426162839;65285;13899.374528146258;16182.919085404497;16266.674666506604;16505.17474126313;16515;11520.884791152148;12603.558875439316;12705.301208433624;12710.555130570385;12764.680882978;17016.744748828776;17424.215910284067;17608.9119554404;17644.382446614305;17656;3230.402375560529;3331.53358529806;5911;7091.078159839188;7212.377215126555;866.9609867555976;943.7074506902882;986.2701600815489;1020.6682828080903;1051.8211903976342;29291.777904430495;29563.408731825242;29987.70135285117;30397.240068998453;30497.695023049928;950.7623094226443;1001.5893483671805;1059.6503153959175;1080.5839751695653;1114.1977776001265;15144.54566363011;15542.989705669095;15556.922215389077;15739.213039347987;16057.357705691875;598270;599002;644655;648984.7550762215;651133;58068.709656452294;58329.416705833246;58369.124463133085;58487.83024339489;58863;1314.7633425983415;1347.4004068189759;1352.4792954712507;1359.1844893064083;1363.4069179906573;24204.515909681355;29458.116256512338;29950;30354;30755.38489230158;55157.89684206213;56298.43701562932;56319.71840140773;56417;56448.15327770169;621735;624104;632305;634607;635020;42682;42926.570734293506;43323.783381082896;43416.78291608522;43439.34840977324;41724.748257552325;46246.306305404774;46548.534514655774;46931.53068469271;47955.760221200064;33270.83364583162;33802.309884505186;39308;39465.60534394619;39505.80247098746;38307.61692383152;38887.80556097201;39147.608523914394;40130;40769.980750481474;37841.351105422356;38236.617633823305;38545.229095418494;38565.6143438562;39457.2108557833;33007.66992330142;34378.82810585931;35132.824335878155;35133;35260.647393526764;25926.740732592432;26233.213003609922;26328.868355658098;26568.202953911412;26726.331841704112 03:32:19 INFO - PROCESS | 1694 | |2;jquery.html;370.6238168259217;373.93830018047026;386.81432912202143;388.316562849385;402.1594866728537;18083.909580452095;20025.899870500627;20603.38189854303;20665.966701664915;20759.792402075975;19876.70184947227;19913.800861991374;20113;20317.49206269844;20384;5173.6119791015635;5365.946340536584;5670.773169073233;5860.238169038041;5932.584719069667;5882.117682347639;5894.145348924403;5951.761929522814;5958.255218097738;5968.492678122343;5603.663780173182;5769.24999750034;5814.563907706939;5845.3862344453855;5895.823125306248;5751.654900705971;5794;5819.098039803816;5820.941790582082;5831.329397119343;4966.975165124151;5061.44324124346;5095.617828662865;5100.668456550349;5109.795608175668;24935.127270545443;25047.749522504906;25066;25098.874505627537;25431.74568254312;2386.1052105460453;2415.7101147862195;2497.2882728422496;2569.5117927593883;2884.8269103853836;14229.430822767077;14261;14325.140491570539;14375.928120359331;15124.924375378163;1796.9820301796944;1845.8523318134517;1877.010369008855;1888.3107665702057;1897.459224121119;124279;125698.3715081428;126635.36682316622;128587;130052;11597.536098555964;11887.465064071965;11969.64091077269;12006.799320068098;12137.968272696744;14543.41826326935;14665.120092794466;14704.411823527153;14715.337809798584;14737.778933316009;6607.372299631624;8278.254957053894;8485.872711909326;8526.445781024213;8573.442726222776;8405.117462666454;8407.159284071544;8426.452280601863;8540.615672294762;8544.060153383123;4518.593326600621;4533.863984080483;4539.364488971547;4559.817607295738;4665.2768820832825;1918.9712154317697;1951.7072439134242;1961.0782932021928;1961.5096225943514;1964.8701996352154;714.989275160873;793.9087004994384;809.6801763303462;906.6464079009191;959.4435227567993;15655.921720391325;19871.900640496995;20442.693359599616;20544.03500919992;20637.690434643493;846.7840700621425;930.1907340613709;938.6949241496404;954.1984732824461;1005.9144972677258;10043.296969212231;10521.736956575995;10627.202959778047;10676;10734.624288149877;560080.399196011;560130.3986960159;618146;621738;642840;75393.62303188449;95704.52147739216;105910.47044764727;124087.13869291967;138389.999999998;965.7392504024015;974.576059414143;993.8062077894741;997.5909876950416;998.6105418886494;18392.540186495444;18987.810121899158;19320.227190912206;19363.709544356563;19365.419037428335;56251.8749624997;56636.43363566312;57033.714831425576;57250.713746431;57892.71053644705;74157.88763168448;79893.60053199697;80032.59983700277;81046.59476702579;83304;7644.774540045863;7980.049875311758;8079.111297757359;8090.47411918247;8273.503589784632;5750.25246717924;7958.045034595654;11065.446727663746;11844.526218951145;12686.302253376152;10848;10895.727606809893;10903.945480272865;10978.12175026012;11217.71955701114;10529;10948.726281842699;11052;11084.334939903632;11178.832317515407;9712.417254964725;11048.668539943814;11148.665540033811;11258.38078905668;11570.016548593127;7903.9209607903185;8033.437659363788;8127.959360203397;8182.1817818217705;8206.753797386087;10437.530311135864;10825.729356766144;10842.674719758419;10853.837192441963;11102.389368584805 03:32:19 INFO - PROCESS | 1694 | |3;mootools.html;1428.9142651440911;1470.5882352941173;1655.9420420285285;1764.3560100563298;1820.781506219254;7505.399568034558;7749.457537972344;8076.3538916886655;8562.315014798825;8565.914340856589;7962.203779622049;8281.089080201173;8318.292945099658;8401.83196336073;8403.747887563382;1947.7565304336958;2312.7857874615834;2340.508493216427;2348.1077190667606;2353.8469999450067;2341.8711970841596;2378.9762102378927;2382.5711371953043;2392.138830021191;2395.520895820834;1912.5887934094167;2324.6745455636224;2364.6689463475127;2364.798992085675;2365.7752513511273;2320.2227253869805;2328.4528135888054;2353.0705371378294;2353.893669975109;2358.327876555191;2359.1742889988536;2364.5034542746043;2370.146747171017;2372.3594629449954;2379.6311571706415;8380.790480237982;8491.19333663301;8542.957285213597;8545.27365173961;8559.74320770378;5082.644214904921;5231.215317702337;5241.528262456397;5254.894902101936;5284.867878303073;2842.2610121368384;3000.264935090895;3210.951835722466;3602.3335682898746;3614.5843228028853;1046.9895301047045;1060.294903888913;1093.0872721277742;1093.103655002898;1110.6334909479851;10932.617358392417;10975.670729878117;11006.669799905936;11040.447977601088;11093.72265693356;4476.395686582269;4569.565891240327;4662.184117779375;4674.859754207379;4682.719036857799;9377.343585949055;9436;9440.858387124199;9482.762930926645;9518.666846660471;5148.819791307286;5159.638825282269;5168.147255702842;5171.5862730981435;5176.327077479904;4205.558416366299;4631.374764406829;4695.694779839368;4759.9524004759505;4764.571188593043;3788.905277368088;3824.4454554089502;3867.5939026402384;3886.5336159660455;3927.3912543555793;1046.6493724602344;1286.466116561635;1290.5289569307135;1292.8125421813784;1298.5195477673321;741.8738814401564;840.3991146330403;896.171041786345;896.9955150224207;907.0113576201971;5566.55467562594;5682.659040457585;5683.857903552362;5704.615906833236;5920;907.9727608171765;952.46661869352;957.3824882950597;958.4153666263574;962.2446379591987;3743.0642339415144;3822.0827001519992;3876.4379165020914;3920.764754114762;3921.31377009028;10149.64476243328;10401.895981040245;10410.583576657;10418.166546676248;10419.426931518688;8631.654733810703;10331.793364132825;10356.585736570603;10368.170546356274;10398.116160126474;7054.470914681317;7408.629568521553;7756.53460792343;7773.455858089879;7778.805529861799;4275.952391664062;5257.553107985864;5628.577856660685;5671.517920976763;6022.759089636365;8022.879656805036;9160.816783664157;9276.211522020434;9440.19758320523;9588.90411095908;7776.611169441619;9258.814823703353;9637.614495420105;9651.613935442785;9662.855057174289;5916.881662366814;6389.840253993687;7106.5736055836815;7128.750493732695;7262.491625586158;7916.960415197887;7995.520268783892;8001.119876813429;8002.799930001796;8057.194280571896;6060.666663333559;7070.823229419306;7197.568145911262;7243.275672432715;7323.816904577428;5901.439363260483;7068.858622827412;7133.928660713534;7157.785266442015;7161.892571611535;6618.437432818265;6705.698243578953;6770.187577490733;6777.830554236183;6789.864202716017;4867.805287788448;4884.365032545888;4911.287863259879;4927.802887884444;4942.184539551077;4587.6788624795945;4828.324034635084;4979.153543897473;4982.526659967298;4992.151334273255 03:32:19 INFO - PROCESS | 1694 | |4;prototype.html;271.4679228711725;302.9257831831202;313.9968600313996;317.94435973704594;318.40140535792705;5421.647592906468;5566.415526369734;5600.747966341514;5691.34549526804;5705.25831641887;4100.651444627203;4888.169011268084;5005.1480952047705;5383.757730902109;5587.552995760339;3476.965230347696;4245.575442455761;4247.214265360903;4255.382969469425;4266.2320782259185;3331.566896303489;4018.276710192164;4039.757614543122;4266.658667306608;4272.594103560173;3519.331327047853;4059.863238293268;4105.363668631367;4161.500619925613;4183.694881043972;3631.3100510902977;4112.02622741083;4160;4160.91678166438;4183.853565125206;3554.59122200945;3575.6960658344074;3579.427291633326;3582.7671201372086;3627.4196128619296;4377.584129507692;5062.367204099488;5136.175103692954;5482.972585137049;5507.7246137692955;4468.396766436555;4528.709317844398;4777.235642297216;4783.641226907961;4810.436608102381;5312.415634280226;5526.861828454281;5757.7908639185825;5907.645541267538;5928.733207005652;3124.2814152744995;3307.6680939937287;3346.882859099944;3899.3566061599804;3922.3332033554366;4887.8778030549165;5287.68273903567;6178.351273116303;6188.938110618927;6191.953557850337;3413.300273443938;3849.4418309344987;3858.823058967042;3889.202713443737;4051.9797401013398;3803.2583646188727;3878.670313023368;4024.2353952748886;4061.5126184857413;4089.5705950875326;4716.3632909557455;4779.283107533898;4792.185328494164;4792.658055744397;4825.445073816486;4907.509249075064;4929.654924155347;5259.658122222043;5917.053271476543;5929.264563325078;1148.3339662995443;1155.624422062833;1170.6371024982284;1267.7844766389735;1321.5440672967811;783.2754701900719;849.6431498770531;859.6975581993286;888.0409158109227;892.8437673213205;4316.784160791948;4826.372571565674;5217.373915130209;5244.659097158673;5282.577393808486;4862.367892173995;5427.511523962862;5750.32609836428;5775.458798128894;5781.508571771363;4531.161735079021;5019.523145301264;5175.249588809676;5196.818111366084;5237.607179461479;2706.579046000865;2767.343350383654;2995.655499617572;3080.9075727728205;3104.611923509561;5445.537129343971;5527.756254842709;5954.791582294599;6046.3651316612;6083.39166083397;4923.104604727206;5036.312835200249;5157.535821776059;5867.530597552186;5999.730012149464;5641.605087643826;5725.591294702972;5858.209141765892;6066.815946259431;6085.326535202855;4766.1659209638865;4896.683451988277;5791.887759690667;5865.677387743715;5871.827423853031;5131.665092382882;5464.606525336014;5728.112142617901;5755.53945692092;5811.157382179645;5347.973260133675;5604.159376093618;6033.849153771191;6135;6170.907436388368;3234.5795046643784;3304.5704058472243;3736.140687641803;3816.7023212106906;3842.615738426247;5345.167061457434;5525.044101405729;5797.362290147996;5832.50423713989;5836.601143941752;5061.16490779032;5201;5344.625876188629;5779.2198053263955;5932.733027013881;4789.87437952074;5012.022655582272;5560;5920.881582368243;5958.404159584007;5046.47012063728;5467.58993075513;5513.448655134454;5650.830475085754;5734.741936612946;4950.727709975986;5603.411641777555;5860.267466566679;5941.613795103304;6001.459868611846;5100.566451851634;5752.026838132527;5793.971030144822;5794.188813566188;5799.724060706638 03:32:19 INFO - PROCESS | 1694 | |5;yui.html;571.3144226927687;701.7122979578373;740.4816628360143;769.4921351907739;794.9324307433869;14095.083819551723;14913.776293355608;14933.925330373346;14937.775933360994;14947.850521494782;13377.26425046622;13471.326433678301;13510.93244533776;13515.32423378832;13518;642.1459458919637;664.5481072870471;792.63142638673;814.5194335342147;831.4138532334689;826.3017750001239;832.6211573733937;833.3666413525704;833.4790755777639;835.995820020899;854.692310768123;869.1135042256894;870.8737233101228;880.9735707928772;884.747846863644;838.5576807890419;858.1675774498789;873.9992708348937;874.7026011156206;876.1063715010686;618.4804763998263;627.7802769030802;652.1098700274092;656;656.1732217406055;13485.19088854662;13645.454181832714;13858.099223550436;13893.652658683513;14527;12218;12358.320292383914;13629.591112266648;14062.226577538231;14121.576352709435;12244.81632775509;12272.631821045383;12385.380730963507;12410.379481025913;12430.627081187578;4387.692861499696;4417.116576684676;4444.911101777979;4446.199684056868;4597.70114942531;89381.99999999935;89617;90792;91614;94834;10264.281500295057;10273.383596984206;10290.331128476626;10368.481575921174;10606.939306069331;20082.99585020743;20372.28696995598;20452.693209601868;20452.897735511226;20460.69308960367;7745.10931242903;7884.369250459949;7903.68385264583;8069.515829050159;8092.919070809335;4312.9137417252105;4328.09110086879;4364.62900653448;4443.733375997451;4495.88760280989;3357.362101200764;3473.565804274466;3477;3480.1821571930577;3481.1993241554583;643.2377632505496;647.2007071266981;671.6977360187935;673.4040374268808;684.9691763870637;588.7203578300273;604.7157835817159;611.5810669691276;656.5273003437518;671.0672165689696;8753.868691969625;9131.406458580172;9222.633738685467;9246.306527010502;9309.72070837876;628.0359647940389;650.4828661214345;660.303379934174;668.0046730371809;669.6919417068106;4332.610065094157;4544.363789069533;4577.130345234395;4602.608778253886;4696.671233013656;106712;121280;121602;122745.38627306807;123531.38234308951;68818.65590672015;69329.26676833018;92836.60745088829;101395;103530.48234758778;73677.26322736811;89139.10860891308;93982.53008734775;94293;96493;8807.163319484638;8931.062238465127;8973.37186396946;9021.639134434548;9032.548372581476;54871;59654.21037368886;61293.38706613055;61507;61548.69225654022;81963.5901820487;83945;87799.12200878165;87833.56083219544;89280;10834.404107773833;11109.611163609236;11113;11124.388158651353;11563.190576659554;11432.371219583003;12207.75584488323;12346.938265308616;12359.50561977511;12442;11559.884401155881;11732.94133529327;11740.119491038377;11776.76446471083;12131.939340303243;12066.698332541757;12072.154949153475;12127.393630318626;12160.878391216329;12360.62918112422;9123.589438475417;11695.707607309885;11698.883011170119;11877.821832672344;12377.690557735768;8243.175682431709;9647.469389183381;9785.266105042008;10165.237607179639;10260.230482713976;8716.694915677921;9842.704718858446;9857.16214121779;10149.34029288094;10245.077942985166 03:32:19 INFO - PROCESS | 1694 | __end_tp_report 03:32:19 INFO - PROCESS | 1694 | __start_cc_report 03:32:19 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,364 03:32:19 INFO - PROCESS | 1694 | __end_cc_report 03:32:19 INFO - PROCESS | 1694 | __startTimestamp1484566339784__endTimestamp 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | ------- Summary: start ------- 03:32:19 INFO - PROCESS | 1694 | Number of tests: 6 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#0] dojo.html Cycles:165 Average:5862.58 Median:6124.14 stddev:700.51 (11.4%) stddev-sans-first:655.37 03:32:19 INFO - PROCESS | 1694 | Values: 2637.3 3396.2 3414.6 3421.2 3442.2 5803.2 5824.5 5867.6 5933.3 5986.2 5903.6 5947.7 5965.2 5987.6 5988.9 4174.6 5328.3 5390.2 5395.4 5424.7 4734.5 5425.5 5428.0 5462.5 5489.7 5285.9 5300.9 5450.2 5467.2 5470.0 5340.2 5344.1 5373.8 5452.5 5477.7 5265.7 5379.4 5387.9 5397.8 5452.1 5730.8 5974.1 6035.4 6074.9 6092.8 6244.7 6262.3 6265.1 6292.6 6316.1 6298.5 6327.4 6358.7 6399.7 6407.6 6088.1 6092.8 6094.3 6121.7 6124.1 6360.9 6374.2 6454.1 6493.4 6531.0 6236.9 6329.1 6329.3 6337.9 6347.7 5057.3 6120.2 6349.7 6357.5 6375.9 6266.5 6291.1 6301.5 6347.4 6386.5 5363.8 6293.0 6296.2 6316.1 6330.8 5076.2 5084.1 5094.2 5096.9 5100.6 4439.2 4439.9 4441.6 4468.7 4537.6 5908.7 6136.5 6139.6 6141.0 6141.6 6365.7 6396.7 6427.6 6433.6 6585.2 5131.5 5977.8 6009.5 6028.6 6081.4 5583.3 5597.8 5607.4 5608.3 5640.5 5411.4 6510.7 6540.5 6556.7 6574.1 6212.2 6264.2 6267.3 6282.0 6397.8 6516.4 6570.7 6586.3 6589.3 6606.4 6256.2 6283.0 6322.8 6352.2 6353.5 5928.1 6177.1 6270.2 6297.4 6388.0 5172.7 6259.3 6316.2 6341.1 6351.2 6271.6 6298.3 6305.1 6326.3 6327.5 5969.2 6033.5 6086.5 6086.8 6213.5 6244.5 6274.1 6300.6 6330.0 6352.3 5009.9 5148.3 6169.1 6195.8 6238.5 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#1] ext.html Cycles:180 Average:72377.38 Median:40096.50 stddev:157981.45 (394.0%) stddev-sans-first:158332.47 03:32:19 INFO - PROCESS | 1694 | Values: 503.7 516.8 521.9 534.4 547.3 37557.8 38409.0 39627.4 39897.6 40000.4 41240.6 41832.6 41979.0 41989.2 42090.8 8168.2 9214.8 9359.6 9519.0 9525.9 9050.8 9439.6 9510.5 9546.5 9571.7 9536.5 9556.1 9557.9 9568.7 9611.1 9418.8 9468.6 9473.0 9486.6 9509.0 9402.8 9415.2 9517.4 9528.6 9642.4 39621.2 39713.0 39940.4 40044.8 40063.0 3090.8 3378.5 3504.5 3696.7 3717.8 29349.6 29392.0 30450.5 30775.4 30832.4 3203.6 3251.4 3259.3 3261.7 3328.7 500932.0 505793.5 507427.0 507694.5 509243.5 62208.8 62272.4 62303.7 62384.7 62520.0 64958.0 65065.0 65147.0 65147.7 65285.0 13899.4 16182.9 16266.7 16505.2 16515.0 11520.9 12603.6 12705.3 12710.6 12764.7 17016.7 17424.2 17608.9 17644.4 17656.0 3230.4 3331.5 5911.0 7091.1 7212.4 867.0 943.7 986.3 1020.7 1051.8 29291.8 29563.4 29987.7 30397.2 30497.7 950.8 1001.6 1059.7 1080.6 1114.2 15144.5 15543.0 15556.9 15739.2 16057.4 598270.0 599002.0 644655.0 648984.8 651133.0 58068.7 58329.4 58369.1 58487.8 58863.0 1314.8 1347.4 1352.5 1359.2 1363.4 24204.5 29458.1 29950.0 30354.0 30755.4 55157.9 56298.4 56319.7 56417.0 56448.2 621735.0 624104.0 632305.0 634607.0 635020.0 42682.0 42926.6 43323.8 43416.8 43439.3 41724.7 46246.3 46548.5 46931.5 47955.8 33270.8 33802.3 39308.0 39465.6 39505.8 38307.6 38887.8 39147.6 40130.0 40770.0 37841.4 38236.6 38545.2 38565.6 39457.2 33007.7 34378.8 35132.8 35133.0 35260.6 25926.7 26233.2 26328.9 26568.2 26726.3 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#2] jquery.html Cycles:180 Average:34890.59 Median:1627.73 stddev:100255.06 (6159.2%) stddev-sans-first:100502.79 03:32:19 INFO - PROCESS | 1694 | Values: 370.6 373.9 386.8 388.3 402.2 18083.9 20025.9 20603.4 20666.0 20759.8 19876.7 19913.8 20113.0 20317.5 20384.0 5173.6 5365.9 5670.8 5860.2 5932.6 5882.1 5894.1 5951.8 5958.3 5968.5 5603.7 5769.2 5814.6 5845.4 5895.8 5751.7 5794.0 5819.1 5820.9 5831.3 4967.0 5061.4 5095.6 5100.7 5109.8 24935.1 25047.7 25066.0 25098.9 25431.7 2386.1 2415.7 2497.3 2569.5 2884.8 14229.4 14261.0 14325.1 14375.9 15124.9 1797.0 1845.9 1877.0 1888.3 1897.5 124279.0 125698.4 126635.4 128587.0 130052.0 11597.5 11887.5 11969.6 12006.8 12138.0 14543.4 14665.1 14704.4 14715.3 14737.8 6607.4 8278.3 8485.9 8526.4 8573.4 8405.1 8407.2 8426.5 8540.6 8544.1 4518.6 4533.9 4539.4 4559.8 4665.3 1919.0 1951.7 1961.1 1961.5 1964.9 715.0 793.9 809.7 906.6 959.4 15655.9 19871.9 20442.7 20544.0 20637.7 846.8 930.2 938.7 954.2 1005.9 10043.3 10521.7 10627.2 10676.0 10734.6 560080.4 560130.4 618146.0 621738.0 642840.0 75393.6 95704.5 105910.5 124087.1 138390.0 965.7 974.6 993.8 997.6 998.6 18392.5 18987.8 19320.2 19363.7 19365.4 56251.9 56636.4 57033.7 57250.7 57892.7 74157.9 79893.6 80032.6 81046.6 83304.0 7644.8 7980.0 8079.1 8090.5 8273.5 5750.3 7958.0 11065.4 11844.5 12686.3 10848.0 10895.7 10903.9 10978.1 11217.7 10529.0 10948.7 11052.0 11084.3 11178.8 9712.4 11048.7 11148.7 11258.4 11570.0 7903.9 8033.4 8128.0 8182.2 8206.8 10437.5 10825.7 10842.7 10853.8 11102.4 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#3] mootools.html Cycles:180 Average:5436.79 Median:5115.73 stddev:2984.97 (58.3%) stddev-sans-first:2978.15 03:32:19 INFO - PROCESS | 1694 | Values: 1428.9 1470.6 1655.9 1764.4 1820.8 7505.4 7749.5 8076.4 8562.3 8565.9 7962.2 8281.1 8318.3 8401.8 8403.7 1947.8 2312.8 2340.5 2348.1 2353.8 2341.9 2379.0 2382.6 2392.1 2395.5 1912.6 2324.7 2364.7 2364.8 2365.8 2320.2 2328.5 2353.1 2353.9 2358.3 2359.2 2364.5 2370.1 2372.4 2379.6 8380.8 8491.2 8543.0 8545.3 8559.7 5082.6 5231.2 5241.5 5254.9 5284.9 2842.3 3000.3 3211.0 3602.3 3614.6 1047.0 1060.3 1093.1 1093.1 1110.6 10932.6 10975.7 11006.7 11040.4 11093.7 4476.4 4569.6 4662.2 4674.9 4682.7 9377.3 9436.0 9440.9 9482.8 9518.7 5148.8 5159.6 5168.1 5171.6 5176.3 4205.6 4631.4 4695.7 4760.0 4764.6 3788.9 3824.4 3867.6 3886.5 3927.4 1046.6 1286.5 1290.5 1292.8 1298.5 741.9 840.4 896.2 897.0 907.0 5566.6 5682.7 5683.9 5704.6 5920.0 908.0 952.5 957.4 958.4 962.2 3743.1 3822.1 3876.4 3920.8 3921.3 10149.6 10401.9 10410.6 10418.2 10419.4 8631.7 10331.8 10356.6 10368.2 10398.1 7054.5 7408.6 7756.5 7773.5 7778.8 4276.0 5257.6 5628.6 5671.5 6022.8 8022.9 9160.8 9276.2 9440.2 9588.9 7776.6 9258.8 9637.6 9651.6 9662.9 5916.9 6389.8 7106.6 7128.8 7262.5 7917.0 7995.5 8001.1 8002.8 8057.2 6060.7 7070.8 7197.6 7243.3 7323.8 5901.4 7068.9 7133.9 7157.8 7161.9 6618.4 6705.7 6770.2 6777.8 6789.9 4867.8 4884.4 4911.3 4927.8 4942.2 4587.7 4828.3 4979.2 4982.5 4992.2 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#4] prototype.html Cycles:180 Average:4576.90 Median:5061.77 stddev:1436.88 (28.4%) stddev-sans-first:1404.10 03:32:19 INFO - PROCESS | 1694 | Values: 271.5 302.9 314.0 317.9 318.4 5421.6 5566.4 5600.7 5691.3 5705.3 4100.7 4888.2 5005.1 5383.8 5587.6 3477.0 4245.6 4247.2 4255.4 4266.2 3331.6 4018.3 4039.8 4266.7 4272.6 3519.3 4059.9 4105.4 4161.5 4183.7 3631.3 4112.0 4160.0 4160.9 4183.9 3554.6 3575.7 3579.4 3582.8 3627.4 4377.6 5062.4 5136.2 5483.0 5507.7 4468.4 4528.7 4777.2 4783.6 4810.4 5312.4 5526.9 5757.8 5907.6 5928.7 3124.3 3307.7 3346.9 3899.4 3922.3 4887.9 5287.7 6178.4 6188.9 6192.0 3413.3 3849.4 3858.8 3889.2 4052.0 3803.3 3878.7 4024.2 4061.5 4089.6 4716.4 4779.3 4792.2 4792.7 4825.4 4907.5 4929.7 5259.7 5917.1 5929.3 1148.3 1155.6 1170.6 1267.8 1321.5 783.3 849.6 859.7 888.0 892.8 4316.8 4826.4 5217.4 5244.7 5282.6 4862.4 5427.5 5750.3 5775.5 5781.5 4531.2 5019.5 5175.2 5196.8 5237.6 2706.6 2767.3 2995.7 3080.9 3104.6 5445.5 5527.8 5954.8 6046.4 6083.4 4923.1 5036.3 5157.5 5867.5 5999.7 5641.6 5725.6 5858.2 6066.8 6085.3 4766.2 4896.7 5791.9 5865.7 5871.8 5131.7 5464.6 5728.1 5755.5 5811.2 5348.0 5604.2 6033.8 6135.0 6170.9 3234.6 3304.6 3736.1 3816.7 3842.6 5345.2 5525.0 5797.4 5832.5 5836.6 5061.2 5201.0 5344.6 5779.2 5932.7 4789.9 5012.0 5560.0 5920.9 5958.4 5046.5 5467.6 5513.4 5650.8 5734.7 4950.7 5603.4 5860.3 5941.6 6001.5 5100.6 5752.0 5794.0 5794.2 5799.7 03:32:19 INFO - PROCESS | 1694 | 03:32:19 INFO - PROCESS | 1694 | [#5] yui.html Cycles:180 Average:21084.07 Median:27721.16 stddev:31763.61 (114.6%) stddev-sans-first:31815.37 03:32:19 INFO - PROCESS | 1694 | Values: 571.3 701.7 740.5 769.5 794.9 14095.1 14913.8 14933.9 14937.8 14947.9 13377.3 13471.3 13510.9 13515.3 13518.0 642.1 664.5 792.6 814.5 831.4 826.3 832.6 833.4 833.5 836.0 854.7 869.1 870.9 881.0 884.7 838.6 858.2 874.0 874.7 876.1 618.5 627.8 652.1 656.0 656.2 13485.2 13645.5 13858.1 13893.7 14527.0 12218.0 12358.3 13629.6 14062.2 14121.6 12244.8 12272.6 12385.4 12410.4 12430.6 4387.7 4417.1 4444.9 4446.2 4597.7 89382.0 89617.0 90792.0 91614.0 94834.0 10264.3 10273.4 10290.3 10368.5 10606.9 20083.0 20372.3 20452.7 20452.9 20460.7 7745.1 7884.4 7903.7 8069.5 8092.9 4312.9 4328.1 4364.6 4443.7 4495.9 3357.4 3473.6 3477.0 3480.2 3481.2 643.2 647.2 671.7 673.4 685.0 588.7 604.7 611.6 656.5 671.1 8753.9 9131.4 9222.6 9246.3 9309.7 628.0 650.5 660.3 668.0 669.7 4332.6 4544.4 4577.1 4602.6 4696.7 106712.0 121280.0 121602.0 122745.4 123531.4 68818.7 69329.3 92836.6 101395.0 103530.5 73677.3 89139.1 93982.5 94293.0 96493.0 8807.2 8931.1 8973.4 9021.6 9032.5 54871.0 59654.2 61293.4 61507.0 61548.7 81963.6 83945.0 87799.1 87833.6 89280.0 10834.4 11109.6 11113.0 11124.4 11563.2 11432.4 12207.8 12346.9 12359.5 12442.0 11559.9 11732.9 11740.1 11776.8 12131.9 12066.7 12072.2 12127.4 12160.9 12360.6 9123.6 11695.7 11698.9 11877.8 12377.7 8243.2 9647.5 9785.3 10165.2 10260.2 8716.7 9842.7 9857.2 10149.3 10245.1 03:32:19 INFO - PROCESS | 1694 | -------- Summary: end -------- 03:32:19 INFO - PROCESS | 1694 | 03:32:20 INFO - TEST-INFO | 1694: exit 0 03:32:20 INFO - TEST-OK | dromaeo_css | took 1115543ms 03:32:20 INFO - TEST-START | kraken 03:32:20 INFO - operating with platform_type : mac_ 03:32:20 INFO - Initialising browser for kraken test... 03:32:20 INFO - TEST-INFO | started process 1813 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpYHDgoy/profile http://localhost:49236/getInfo.html) 03:32:23 INFO - PROCESS | 1813 | 2017-01-16 03:32:23.434 plugin-container[1814:10609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 03:32:23 INFO - PROCESS | 1813 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:32:23 INFO - PROCESS | 1813 | 2017-01-16 03:32:23.437 plugin-container[1814:10609] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 03:32:23 INFO - PROCESS | 1813 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:32:23 INFO - PROCESS | 1813 | 2017-01-16 03:32:23.437 plugin-container[1814:10609] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:32:23 INFO - PROCESS | 1813 | __metrics Screen width/height:1600/1200 03:32:23 INFO - PROCESS | 1813 | colorDepth:24 03:32:23 INFO - PROCESS | 1813 | Browser inner width/height: 1024/689 03:32:23 INFO - PROCESS | 1813 | __metrics 03:32:23 ERROR - PROCESS | 1813 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 03:32:24 INFO - TEST-INFO | 1813: exit 0 03:32:24 INFO - Browser initialized. 03:32:24 INFO - Running cycle 1/1 for kraken test... 03:32:24 INFO - TEST-INFO | started process 1816 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpYHDgoy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:27 INFO - PROCESS | 1816 | 2017-01-16 03:32:27.245 plugin-container[1817:10731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 03:32:27 INFO - PROCESS | 1816 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:32:27 INFO - PROCESS | 1816 | 2017-01-16 03:32:27.246 plugin-container[1817:10731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 03:32:27 INFO - PROCESS | 1816 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:32:27 INFO - PROCESS | 1816 | 2017-01-16 03:32:27.246 plugin-container[1817:10731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:32:36 INFO - PROCESS | 1816 | RSS: Main: 228757504 03:32:36 INFO - PROCESS | 1816 | 03:32:39 INFO - PROCESS | 1816 | 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) 03:32:40 INFO - PROCESS | 1816 | RSS: Main: 241049600 03:32:40 INFO - PROCESS | 1816 | 03:32:43 INFO - PROCESS | 1816 | 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) 03:32:44 INFO - PROCESS | 1816 | RSS: Main: 249106432 03:32:44 INFO - PROCESS | 1816 | 03:32:47 INFO - PROCESS | 1816 | 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) 03:32:47 INFO - PROCESS | 1816 | RSS: Main: 252743680 03:32:47 INFO - PROCESS | 1816 | 03:32:49 INFO - PROCESS | 1816 | 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) 03:32:50 INFO - PROCESS | 1816 | RSS: Main: 253452288 03:32:50 INFO - PROCESS | 1816 | 03:32:52 INFO - PROCESS | 1816 | 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) 03:32:53 INFO - PROCESS | 1816 | RSS: Main: 254472192 03:32:53 INFO - PROCESS | 1816 | 03:32:55 INFO - PROCESS | 1816 | 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) 03:32:56 INFO - PROCESS | 1816 | RSS: Main: 258416640 03:32:56 INFO - PROCESS | 1816 | 03:32:59 INFO - PROCESS | 1816 | 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) 03:33:00 INFO - PROCESS | 1816 | RSS: Main: 258494464 03:33:00 INFO - PROCESS | 1816 | 03:33:03 INFO - PROCESS | 1816 | 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) 03:33:03 INFO - PROCESS | 1816 | RSS: Main: 258138112 03:33:03 INFO - PROCESS | 1816 | 03:33:05 INFO - PROCESS | 1816 | 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) 03:33:06 INFO - PROCESS | 1816 | RSS: Main: 257323008 03:33:06 INFO - PROCESS | 1816 | 03:33:08 INFO - PROCESS | 1816 | 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) 03:33:08 INFO - PROCESS | 1816 | RSS: Main: 257163264 03:33:08 INFO - PROCESS | 1816 | 03:33:10 INFO - PROCESS | 1816 | 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) 03:33:11 INFO - PROCESS | 1816 | RSS: Main: 257007616 03:33:11 INFO - PROCESS | 1816 | 03:33:14 INFO - PROCESS | 1816 | 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) 03:33:15 INFO - PROCESS | 1816 | RSS: Main: 257310720 03:33:15 INFO - PROCESS | 1816 | 03:33:18 INFO - PROCESS | 1816 | 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) 03:33:18 INFO - PROCESS | 1816 | RSS: Main: 257470464 03:33:18 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | 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) 03:33:20 INFO - PROCESS | 1816 | RSS: Main: 259276800 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | __start_tp_report 03:33:20 INFO - PROCESS | 1816 | _x_x_mozilla_page_load 03:33:20 INFO - PROCESS | 1816 | _x_x_mozilla_page_load_details 03:33:20 INFO - PROCESS | 1816 | |i|pagename|runs| 03:33:20 INFO - PROCESS | 1816 | |0;ai-astar;106;126;167;118;117;119;120;117;118;120 03:33:20 INFO - PROCESS | 1816 | |1;audio-beat-detection;140;115;130;148;121;113;115;117;188;141 03:33:20 INFO - PROCESS | 1816 | |2;audio-dft;195;198;194;196;197;193;195;192;200;195 03:33:20 INFO - PROCESS | 1816 | |3;audio-fft;79;59;60;86;61;69;61;73;81;61 03:33:20 INFO - PROCESS | 1816 | |4;audio-oscillator;84;72;90;73;70;75;101;93;69;88 03:33:20 INFO - PROCESS | 1816 | |5;imaging-gaussian-blur;93;87;89;132;135;101;91;87;89;87 03:33:20 INFO - PROCESS | 1816 | |6;imaging-darkroom;95;97;95;94;95;101;91;155;108;103 03:33:20 INFO - PROCESS | 1816 | |7;imaging-desaturate;107;91;119;86;133;133;104;147;126;72 03:33:20 INFO - PROCESS | 1816 | |8;json-parse-financial;46;48;75;62;60;60;66;71;59;60 03:33:20 INFO - PROCESS | 1816 | |9;json-stringify-tinderbox;70;91;93;100;64;84;62;96;110;106 03:33:20 INFO - PROCESS | 1816 | |10;stanford-crypto-aes;96;84;85;84;85;83;82;85;96;81 03:33:20 INFO - PROCESS | 1816 | |11;stanford-crypto-ccm;139;139;139;144;147;154;160;151;248;182 03:33:20 INFO - PROCESS | 1816 | |12;stanford-crypto-pbkdf2;167;171;168;167;168;165;149;225;168;165 03:33:20 INFO - PROCESS | 1816 | |13;stanford-crypto-sha256-iterative;70;80;67;62;77;88;77;67;65;69 03:33:20 INFO - PROCESS | 1816 | __end_tp_report 03:33:20 INFO - PROCESS | 1816 | __start_cc_report 03:33:20 INFO - PROCESS | 1816 | _x_x_mozilla_cycle_collect,947 03:33:20 INFO - PROCESS | 1816 | __end_cc_report 03:33:20 INFO - PROCESS | 1816 | __startTimestamp1484566400831__endTimestamp 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | ------- Summary: start ------- 03:33:20 INFO - PROCESS | 1816 | Number of tests: 14 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#0] ai-astar Cycles:10 Average:122.80 Median:119.50 stddev:16.29 (13.6%) stddev-sans-first:16.11 03:33:20 INFO - PROCESS | 1816 | Values: 106.0 126.0 167.0 118.0 117.0 119.0 120.0 117.0 118.0 120.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:135.00 stddev:23.14 (17.1%) stddev-sans-first:24.40 03:33:20 INFO - PROCESS | 1816 | Values: 140.0 115.0 130.0 148.0 121.0 113.0 115.0 117.0 188.0 141.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#2] audio-dft Cycles:10 Average:195.50 Median:195.50 stddev:2.37 (1.2%) stddev-sans-first:2.51 03:33:20 INFO - PROCESS | 1816 | Values: 195.0 198.0 194.0 196.0 197.0 193.0 195.0 192.0 200.0 195.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#3] audio-fft Cycles:10 Average:69.00 Median:71.00 stddev:10.12 (14.3%) stddev-sans-first:10.07 03:33:20 INFO - PROCESS | 1816 | Values: 79.0 59.0 60.0 86.0 61.0 69.0 61.0 73.0 81.0 61.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:79.50 stddev:11.19 (14.1%) stddev-sans-first:11.83 03:33:20 INFO - PROCESS | 1816 | Values: 84.0 72.0 90.0 73.0 70.0 75.0 101.0 93.0 69.0 88.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:88.00 stddev:18.62 (21.2%) stddev-sans-first:19.62 03:33:20 INFO - PROCESS | 1816 | Values: 93.0 87.0 89.0 132.0 135.0 101.0 91.0 87.0 89.0 87.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:94.50 stddev:18.81 (19.9%) stddev-sans-first:19.70 03:33:20 INFO - PROCESS | 1816 | Values: 95.0 97.0 95.0 94.0 95.0 101.0 91.0 155.0 108.0 103.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#7] imaging-desaturate Cycles:10 Average:111.80 Median:140.00 stddev:23.94 (17.1%) stddev-sans-first:25.33 03:33:20 INFO - PROCESS | 1816 | Values: 107.0 91.0 119.0 86.0 133.0 133.0 104.0 147.0 126.0 72.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:8.96 (14.7%) stddev-sans-first:7.76 03:33:20 INFO - PROCESS | 1816 | Values: 46.0 48.0 75.0 62.0 60.0 60.0 66.0 71.0 59.0 60.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#9] json-stringify-tinderbox Cycles:10 Average:87.60 Median:77.00 stddev:17.13 (22.2%) stddev-sans-first:16.94 03:33:20 INFO - PROCESS | 1816 | Values: 70.0 91.0 93.0 100.0 64.0 84.0 62.0 96.0 110.0 106.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.00 stddev:5.38 (6.3%) stddev-sans-first:4.36 03:33:20 INFO - PROCESS | 1816 | Values: 96.0 84.0 85.0 84.0 85.0 83.0 82.0 85.0 96.0 81.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#11] stanford-crypto-ccm Cycles:10 Average:160.30 Median:152.50 stddev:33.49 (22.0%) stddev-sans-first:34.62 03:33:20 INFO - PROCESS | 1816 | Values: 139.0 139.0 139.0 144.0 147.0 154.0 160.0 151.0 248.0 182.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:168.00 stddev:19.80 (11.8%) stddev-sans-first:20.95 03:33:20 INFO - PROCESS | 1816 | Values: 167.0 171.0 168.0 167.0 168.0 165.0 149.0 225.0 168.0 165.0 03:33:20 INFO - PROCESS | 1816 | 03:33:20 INFO - PROCESS | 1816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.50 stddev:8.04 (10.9%) stddev-sans-first:8.49 03:33:20 INFO - PROCESS | 1816 | Values: 70.0 80.0 67.0 62.0 77.0 88.0 77.0 67.0 65.0 69.0 03:33:20 INFO - PROCESS | 1816 | -------- Summary: end -------- 03:33:20 INFO - PROCESS | 1816 | 03:33:21 INFO - TEST-INFO | 1816: exit 0 03:33:21 INFO - TEST-OK | kraken | took 61462ms 03:33:21 INFO - SUITE-END | took 1177s 03:33:21 INFO - Completed test suite (00:19:37) 03:33:21 INFO - javascript benchmark 03:33:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7262.806701661244, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.3274814922197, 3396.167938854979, 3414.6073201581826, 3421.247325588371, 3442.156671615455, 5803.187553742474, 5824.475797178253, 5867.55993300502, 5933.288005439343, 5986.221791167142, 5903.586748927577, 5947.732352044158, 5965.164876917235, 5987.5509336799805, 5988.910166347498, 4174.561671024544, 5328.307320048389, 5390.245365648812, 5395.433479484656, 5424.674519528841, 4734.455537613167, 5425.538829199503, 5427.972860135694, 5462.481064298885, 5489.725513724317, 5285.920711189336, 5300.946990530103, 5450.182472629118, 5467.152591348327, 5470.0, 5340.225667278261, 5344.144936810111, 5373.785048598052, 5452.482014208684, 5477.726113694339, 5265.736713164327, 5379.435159308256, 5387.946120538783, 5397.8380648580605, 5452.1276595744885, 5730.82807515771, 5974.103884417372, 6035.366286539938, 6074.939250607482, 6092.847678808021, 6244.718987645567, 6262.2798378186635, 6265.122882796367, 6292.5595208335435, 6316.052592111174, 6298.49612031041, 6327.430531252164, 6358.713857876407, 6399.680015999182, 6407.583507072025, 6088.11722300264, 6092.786752463687, 6094.268687757498, 6121.693915304217, 6124.142620033199, 6360.872782544323, 6374.171357723466, 6454.128692626436, 6493.415592596689, 6530.967345163339, 6236.937630623726, 6329.050642403677, 6329.272133704683, 6337.904931426032, 6347.71435285404, 5057.266696329012, 6120.203342909657, 6349.682515874188, 6357.4596159326975, 6375.904361434582, 6266.467350275278, 6291.1192433059405, 6301.495880329563, 6347.365263473615, 6386.521010924199, 5363.839084827461, 6292.993121100602, 6296.150019747367, 6316.084167795644, 6330.841728956813, 5076.238564215323, 5084.084864724311, 5094.235864620263, 5096.898062038738, 5100.56645185156, 4439.156560253541, 4439.889002774957, 4441.578050085237, 4468.709533880287, 4537.6143027843, 5908.675022873783, 6136.53592945783, 6139.631622102688, 6140.969295153585, 6141.6007959482495, 6365.7096192724675, 6396.680165991682, 6427.58220715652, 6433.613983161025, 6585.209774827052, 5131.538161565402, 5977.834322307195, 6009.489193418521, 6028.577999540078, 6081.361457046946, 5583.274174357308, 5597.832065038056, 5607.355154157242, 5608.270924779753, 5640.520555752725, 5411.350637923317, 6510.707018184193, 6540.542162048611, 6556.704948277244, 6574.112494813235, 6212.161358216583, 6264.185655864709, 6267.341929097379, 6282.026285925689, 6397.840053998501, 6516.446102081187, 6570.671466426755, 6586.275509693834, 6589.275179730322, 6606.43845273138, 6256.173855778598, 6282.968585157045, 6322.810315690536, 6352.205974253218, 6353.4599559038, 5928.110783382527, 6177.104319873503, 6270.184875966278, 6297.4017468340435, 6388.041793730978, 5172.7413629319135, 6259.311475737756, 6316.178896743394, 6341.0805433212845, 6351.2060992375955, 6271.62370257786, 6298.307186209605, 6305.085762564494, 6326.33573474797, 6327.462165715966, 5969.164316995537, 6033.517318614413, 6086.452219300284, 6086.786962456293, 6213.5339849510565, 6244.469220116341, 6274.121622972696, 6300.558960872878, 6329.968350158219, 6352.301246862934, 5009.949900500948, 5148.279240906351, 6169.074638804036, 6195.845103872259, 6238.532110091852], "value": 5816.930715845067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.68771361755694, 516.8475299786563, 521.8617066477382, 534.3961323704214, 547.2994566954297, 37557.812210938944, 38409.0, 39627.40558891619, 39897.60102398975, 40000.39999400004, 41240.58759412405, 41832.581674183246, 41979.0, 41989.160216795724, 42090.78954605223, 8168.224018718242, 9214.769630759218, 9359.578818953129, 9519.048095190461, 9525.904740952572, 9050.818983620324, 9439.575219115157, 9510.47692376919, 9546.474943878084, 9571.712848614517, 9536.52317384128, 9556.139947404732, 9557.856632150524, 9568.712938611852, 9611.086946740048, 9418.764530886714, 9468.57391417388, 9473.0, 9486.620535178585, 9508.952455237748, 9402.811943761086, 9415.199708024826, 9517.381370210915, 9528.618855245782, 9642.42145471274, 39621.20757584832, 39713.0, 39940.40089398661, 40044.79977600122, 40063.0, 3090.8300043497597, 3378.4932260160926, 3504.4653993913034, 3696.685781708558, 3717.8141092945516, 29349.559756603667, 29391.971281005062, 30450.54324185139, 30775.38449231025, 30832.38335233283, 3203.6475987641343, 3251.3984912790975, 3259.3481303739345, 3261.706446419834, 3328.7350806693303, 500932.0, 505793.47103264247, 507427.0, 507694.46152769367, 509243.4537827324, 62208.75582488325, 62272.37727622756, 62303.6884815573, 62384.68807655932, 62520.0, 64958.0, 65065.0, 65147.0, 65147.67426162839, 65285.0, 13899.374528146258, 16182.919085404497, 16266.674666506604, 16505.17474126313, 16515.0, 11520.884791152148, 12603.558875439316, 12705.301208433624, 12710.555130570385, 12764.680882978, 17016.744748828776, 17424.215910284067, 17608.9119554404, 17644.382446614305, 17656.0, 3230.402375560529, 3331.53358529806, 5911.0, 7091.078159839188, 7212.377215126555, 866.9609867555976, 943.7074506902882, 986.2701600815489, 1020.6682828080903, 1051.8211903976342, 29291.777904430495, 29563.408731825242, 29987.70135285117, 30397.240068998453, 30497.695023049928, 950.7623094226443, 1001.5893483671805, 1059.6503153959175, 1080.5839751695653, 1114.1977776001265, 15144.54566363011, 15542.989705669095, 15556.922215389077, 15739.213039347987, 16057.357705691875, 598270.0, 599002.0, 644655.0, 648984.7550762215, 651133.0, 58068.709656452294, 58329.416705833246, 58369.124463133085, 58487.83024339489, 58863.0, 1314.7633425983415, 1347.4004068189759, 1352.4792954712507, 1359.1844893064083, 1363.4069179906573, 24204.515909681355, 29458.116256512338, 29950.0, 30354.0, 30755.38489230158, 55157.89684206213, 56298.43701562932, 56319.71840140773, 56417.0, 56448.15327770169, 621735.0, 624104.0, 632305.0, 634607.0, 635020.0, 42682.0, 42926.570734293506, 43323.783381082896, 43416.78291608522, 43439.34840977324, 41724.748257552325, 46246.306305404774, 46548.534514655774, 46931.53068469271, 47955.760221200064, 33270.83364583162, 33802.309884505186, 39308.0, 39465.60534394619, 39505.80247098746, 38307.61692383152, 38887.80556097201, 39147.608523914394, 40130.0, 40769.980750481474, 37841.351105422356, 38236.617633823305, 38545.229095418494, 38565.6143438562, 39457.2108557833, 33007.66992330142, 34378.82810585931, 35132.824335878155, 35133.0, 35260.647393526764, 25926.740732592432, 26233.213003609922, 26328.868355658098, 26568.202953911412, 26726.331841704112], "value": 20091.939186425832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.6238168259217, 373.93830018047026, 386.81432912202143, 388.316562849385, 402.1594866728537, 18083.909580452095, 20025.899870500627, 20603.38189854303, 20665.966701664915, 20759.792402075975, 19876.70184947227, 19913.800861991374, 20113.0, 20317.49206269844, 20384.0, 5173.6119791015635, 5365.946340536584, 5670.773169073233, 5860.238169038041, 5932.584719069667, 5882.117682347639, 5894.145348924403, 5951.761929522814, 5958.255218097738, 5968.492678122343, 5603.663780173182, 5769.24999750034, 5814.563907706939, 5845.3862344453855, 5895.823125306248, 5751.654900705971, 5794.0, 5819.098039803816, 5820.941790582082, 5831.329397119343, 4966.975165124151, 5061.44324124346, 5095.617828662865, 5100.668456550349, 5109.795608175668, 24935.127270545443, 25047.749522504906, 25066.0, 25098.874505627537, 25431.74568254312, 2386.1052105460453, 2415.7101147862195, 2497.2882728422496, 2569.5117927593883, 2884.8269103853836, 14229.430822767077, 14261.0, 14325.140491570539, 14375.928120359331, 15124.924375378163, 1796.9820301796944, 1845.8523318134517, 1877.010369008855, 1888.3107665702057, 1897.459224121119, 124279.0, 125698.3715081428, 126635.36682316622, 128587.0, 130052.0, 11597.536098555964, 11887.465064071965, 11969.64091077269, 12006.799320068098, 12137.968272696744, 14543.41826326935, 14665.120092794466, 14704.411823527153, 14715.337809798584, 14737.778933316009, 6607.372299631624, 8278.254957053894, 8485.872711909326, 8526.445781024213, 8573.442726222776, 8405.117462666454, 8407.159284071544, 8426.452280601863, 8540.615672294762, 8544.060153383123, 4518.593326600621, 4533.863984080483, 4539.364488971547, 4559.817607295738, 4665.2768820832825, 1918.9712154317697, 1951.7072439134242, 1961.0782932021928, 1961.5096225943514, 1964.8701996352154, 714.989275160873, 793.9087004994384, 809.6801763303462, 906.6464079009191, 959.4435227567993, 15655.921720391325, 19871.900640496995, 20442.693359599616, 20544.03500919992, 20637.690434643493, 846.7840700621425, 930.1907340613709, 938.6949241496404, 954.1984732824461, 1005.9144972677258, 10043.296969212231, 10521.736956575995, 10627.202959778047, 10676.0, 10734.624288149877, 560080.399196011, 560130.3986960159, 618146.0, 621738.0, 642840.0, 75393.62303188449, 95704.52147739216, 105910.47044764727, 124087.13869291967, 138389.999999998, 965.7392504024015, 974.576059414143, 993.8062077894741, 997.5909876950416, 998.6105418886494, 18392.540186495444, 18987.810121899158, 19320.227190912206, 19363.709544356563, 19365.419037428335, 56251.8749624997, 56636.43363566312, 57033.714831425576, 57250.713746431, 57892.71053644705, 74157.88763168448, 79893.60053199697, 80032.59983700277, 81046.59476702579, 83304.0, 7644.774540045863, 7980.049875311758, 8079.111297757359, 8090.47411918247, 8273.503589784632, 5750.25246717924, 7958.045034595654, 11065.446727663746, 11844.526218951145, 12686.302253376152, 10848.0, 10895.727606809893, 10903.945480272865, 10978.12175026012, 11217.71955701114, 10529.0, 10948.726281842699, 11052.0, 11084.334939903632, 11178.832317515407, 9712.417254964725, 11048.668539943814, 11148.665540033811, 11258.38078905668, 11570.016548593127, 7903.9209607903185, 8033.437659363788, 8127.959360203397, 8182.1817818217705, 8206.753797386087, 10437.530311135864, 10825.729356766144, 10842.674719758419, 10853.837192441963, 11102.389368584805], "value": 9513.543242507198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.9142651440911, 1470.5882352941173, 1655.9420420285285, 1764.3560100563298, 1820.781506219254, 7505.399568034558, 7749.457537972344, 8076.3538916886655, 8562.315014798825, 8565.914340856589, 7962.203779622049, 8281.089080201173, 8318.292945099658, 8401.83196336073, 8403.747887563382, 1947.7565304336958, 2312.7857874615834, 2340.508493216427, 2348.1077190667606, 2353.8469999450067, 2341.8711970841596, 2378.9762102378927, 2382.5711371953043, 2392.138830021191, 2395.520895820834, 1912.5887934094167, 2324.6745455636224, 2364.6689463475127, 2364.798992085675, 2365.7752513511273, 2320.2227253869805, 2328.4528135888054, 2353.0705371378294, 2353.893669975109, 2358.327876555191, 2359.1742889988536, 2364.5034542746043, 2370.146747171017, 2372.3594629449954, 2379.6311571706415, 8380.790480237982, 8491.19333663301, 8542.957285213597, 8545.27365173961, 8559.74320770378, 5082.644214904921, 5231.215317702337, 5241.528262456397, 5254.894902101936, 5284.867878303073, 2842.2610121368384, 3000.264935090895, 3210.951835722466, 3602.3335682898746, 3614.5843228028853, 1046.9895301047045, 1060.294903888913, 1093.0872721277742, 1093.103655002898, 1110.6334909479851, 10932.617358392417, 10975.670729878117, 11006.669799905936, 11040.447977601088, 11093.72265693356, 4476.395686582269, 4569.565891240327, 4662.184117779375, 4674.859754207379, 4682.719036857799, 9377.343585949055, 9436.0, 9440.858387124199, 9482.762930926645, 9518.666846660471, 5148.819791307286, 5159.638825282269, 5168.147255702842, 5171.5862730981435, 5176.327077479904, 4205.558416366299, 4631.374764406829, 4695.694779839368, 4759.9524004759505, 4764.571188593043, 3788.905277368088, 3824.4454554089502, 3867.5939026402384, 3886.5336159660455, 3927.3912543555793, 1046.6493724602344, 1286.466116561635, 1290.5289569307135, 1292.8125421813784, 1298.5195477673321, 741.8738814401564, 840.3991146330403, 896.171041786345, 896.9955150224207, 907.0113576201971, 5566.55467562594, 5682.659040457585, 5683.857903552362, 5704.615906833236, 5920.0, 907.9727608171765, 952.46661869352, 957.3824882950597, 958.4153666263574, 962.2446379591987, 3743.0642339415144, 3822.0827001519992, 3876.4379165020914, 3920.764754114762, 3921.31377009028, 10149.64476243328, 10401.895981040245, 10410.583576657, 10418.166546676248, 10419.426931518688, 8631.654733810703, 10331.793364132825, 10356.585736570603, 10368.170546356274, 10398.116160126474, 7054.470914681317, 7408.629568521553, 7756.53460792343, 7773.455858089879, 7778.805529861799, 4275.952391664062, 5257.553107985864, 5628.577856660685, 5671.517920976763, 6022.759089636365, 8022.879656805036, 9160.816783664157, 9276.211522020434, 9440.19758320523, 9588.90411095908, 7776.611169441619, 9258.814823703353, 9637.614495420105, 9651.613935442785, 9662.855057174289, 5916.881662366814, 6389.840253993687, 7106.5736055836815, 7128.750493732695, 7262.491625586158, 7916.960415197887, 7995.520268783892, 8001.119876813429, 8002.799930001796, 8057.194280571896, 6060.666663333559, 7070.823229419306, 7197.568145911262, 7243.275672432715, 7323.816904577428, 5901.439363260483, 7068.858622827412, 7133.928660713534, 7157.785266442015, 7161.892571611535, 6618.437432818265, 6705.698243578953, 6770.187577490733, 6777.830554236183, 6789.864202716017, 4867.805287788448, 4884.365032545888, 4911.287863259879, 4927.802887884444, 4942.184539551077, 4587.6788624795945, 4828.324034635084, 4979.153543897473, 4982.526659967298, 4992.151334273255], "value": 4416.266847384176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.4679228711725, 302.9257831831202, 313.9968600313996, 317.94435973704594, 318.40140535792705, 5421.647592906468, 5566.415526369734, 5600.747966341514, 5691.34549526804, 5705.25831641887, 4100.651444627203, 4888.169011268084, 5005.1480952047705, 5383.757730902109, 5587.552995760339, 3476.965230347696, 4245.575442455761, 4247.214265360903, 4255.382969469425, 4266.2320782259185, 3331.566896303489, 4018.276710192164, 4039.757614543122, 4266.658667306608, 4272.594103560173, 3519.331327047853, 4059.863238293268, 4105.363668631367, 4161.500619925613, 4183.694881043972, 3631.3100510902977, 4112.02622741083, 4160.0, 4160.91678166438, 4183.853565125206, 3554.59122200945, 3575.6960658344074, 3579.427291633326, 3582.7671201372086, 3627.4196128619296, 4377.584129507692, 5062.367204099488, 5136.175103692954, 5482.972585137049, 5507.7246137692955, 4468.396766436555, 4528.709317844398, 4777.235642297216, 4783.641226907961, 4810.436608102381, 5312.415634280226, 5526.861828454281, 5757.7908639185825, 5907.645541267538, 5928.733207005652, 3124.2814152744995, 3307.6680939937287, 3346.882859099944, 3899.3566061599804, 3922.3332033554366, 4887.8778030549165, 5287.68273903567, 6178.351273116303, 6188.938110618927, 6191.953557850337, 3413.300273443938, 3849.4418309344987, 3858.823058967042, 3889.202713443737, 4051.9797401013398, 3803.2583646188727, 3878.670313023368, 4024.2353952748886, 4061.5126184857413, 4089.5705950875326, 4716.3632909557455, 4779.283107533898, 4792.185328494164, 4792.658055744397, 4825.445073816486, 4907.509249075064, 4929.654924155347, 5259.658122222043, 5917.053271476543, 5929.264563325078, 1148.3339662995443, 1155.624422062833, 1170.6371024982284, 1267.7844766389735, 1321.5440672967811, 783.2754701900719, 849.6431498770531, 859.6975581993286, 888.0409158109227, 892.8437673213205, 4316.784160791948, 4826.372571565674, 5217.373915130209, 5244.659097158673, 5282.577393808486, 4862.367892173995, 5427.511523962862, 5750.32609836428, 5775.458798128894, 5781.508571771363, 4531.161735079021, 5019.523145301264, 5175.249588809676, 5196.818111366084, 5237.607179461479, 2706.579046000865, 2767.343350383654, 2995.655499617572, 3080.9075727728205, 3104.611923509561, 5445.537129343971, 5527.756254842709, 5954.791582294599, 6046.3651316612, 6083.39166083397, 4923.104604727206, 5036.312835200249, 5157.535821776059, 5867.530597552186, 5999.730012149464, 5641.605087643826, 5725.591294702972, 5858.209141765892, 6066.815946259431, 6085.326535202855, 4766.1659209638865, 4896.683451988277, 5791.887759690667, 5865.677387743715, 5871.827423853031, 5131.665092382882, 5464.606525336014, 5728.112142617901, 5755.53945692092, 5811.157382179645, 5347.973260133675, 5604.159376093618, 6033.849153771191, 6135.0, 6170.907436388368, 3234.5795046643784, 3304.5704058472243, 3736.140687641803, 3816.7023212106906, 3842.615738426247, 5345.167061457434, 5525.044101405729, 5797.362290147996, 5832.50423713989, 5836.601143941752, 5061.16490779032, 5201.0, 5344.625876188629, 5779.2198053263955, 5932.733027013881, 4789.87437952074, 5012.022655582272, 5560.0, 5920.881582368243, 5958.404159584007, 5046.47012063728, 5467.58993075513, 5513.448655134454, 5650.830475085754, 5734.741936612946, 4950.727709975986, 5603.411641777555, 5860.267466566679, 5941.613795103304, 6001.459868611846, 5100.566451851634, 5752.026838132527, 5793.971030144822, 5794.188813566188, 5799.724060706638], "value": 4111.756307909413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3144226927687, 701.7122979578373, 740.4816628360143, 769.4921351907739, 794.9324307433869, 14095.083819551723, 14913.776293355608, 14933.925330373346, 14937.775933360994, 14947.850521494782, 13377.26425046622, 13471.326433678301, 13510.93244533776, 13515.32423378832, 13518.0, 642.1459458919637, 664.5481072870471, 792.63142638673, 814.5194335342147, 831.4138532334689, 826.3017750001239, 832.6211573733937, 833.3666413525704, 833.4790755777639, 835.995820020899, 854.692310768123, 869.1135042256894, 870.8737233101228, 880.9735707928772, 884.747846863644, 838.5576807890419, 858.1675774498789, 873.9992708348937, 874.7026011156206, 876.1063715010686, 618.4804763998263, 627.7802769030802, 652.1098700274092, 656.0, 656.1732217406055, 13485.19088854662, 13645.454181832714, 13858.099223550436, 13893.652658683513, 14527.0, 12218.0, 12358.320292383914, 13629.591112266648, 14062.226577538231, 14121.576352709435, 12244.81632775509, 12272.631821045383, 12385.380730963507, 12410.379481025913, 12430.627081187578, 4387.692861499696, 4417.116576684676, 4444.911101777979, 4446.199684056868, 4597.70114942531, 89381.99999999935, 89617.0, 90792.0, 91614.0, 94834.0, 10264.281500295057, 10273.383596984206, 10290.331128476626, 10368.481575921174, 10606.939306069331, 20082.99585020743, 20372.28696995598, 20452.693209601868, 20452.897735511226, 20460.69308960367, 7745.10931242903, 7884.369250459949, 7903.68385264583, 8069.515829050159, 8092.919070809335, 4312.9137417252105, 4328.09110086879, 4364.62900653448, 4443.733375997451, 4495.88760280989, 3357.362101200764, 3473.565804274466, 3477.0, 3480.1821571930577, 3481.1993241554583, 643.2377632505496, 647.2007071266981, 671.6977360187935, 673.4040374268808, 684.9691763870637, 588.7203578300273, 604.7157835817159, 611.5810669691276, 656.5273003437518, 671.0672165689696, 8753.868691969625, 9131.406458580172, 9222.633738685467, 9246.306527010502, 9309.72070837876, 628.0359647940389, 650.4828661214345, 660.303379934174, 668.0046730371809, 669.6919417068106, 4332.610065094157, 4544.363789069533, 4577.130345234395, 4602.608778253886, 4696.671233013656, 106712.0, 121280.0, 121602.0, 122745.38627306807, 123531.38234308951, 68818.65590672015, 69329.26676833018, 92836.60745088829, 101395.0, 103530.48234758778, 73677.26322736811, 89139.10860891308, 93982.53008734775, 94293.0, 96493.0, 8807.163319484638, 8931.062238465127, 8973.37186396946, 9021.639134434548, 9032.548372581476, 54871.0, 59654.21037368886, 61293.38706613055, 61507.0, 61548.69225654022, 81963.5901820487, 83945.0, 87799.12200878165, 87833.56083219544, 89280.0, 10834.404107773833, 11109.611163609236, 11113.0, 11124.388158651353, 11563.190576659554, 11432.371219583003, 12207.75584488323, 12346.938265308616, 12359.50561977511, 12442.0, 11559.884401155881, 11732.94133529327, 11740.119491038377, 11776.76446471083, 12131.939340303243, 12066.698332541757, 12072.154949153475, 12127.393630318626, 12160.878391216329, 12360.62918112422, 9123.589438475417, 11695.707607309885, 11698.883011170119, 11877.821832672344, 12377.690557735768, 8243.175682431709, 9647.469389183381, 9785.266105042008, 10165.237607179639, 10260.230482713976, 8716.694915677921, 9842.704718858446, 9857.16214121779, 10149.34029288094, 10245.077942985166], "value": 7268.408918275325, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 126.0, 167.0, 118.0, 117.0, 119.0, 120.0, 117.0, 118.0, 120.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 130.0, 148.0, 121.0, 113.0, 115.0, 117.0, 188.0, 141.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 194.0, 196.0, 197.0, 193.0, 195.0, 192.0, 200.0, 195.0], "value": 195.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 60.0, 86.0, 61.0, 69.0, 61.0, 73.0, 81.0, 61.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 90.0, 73.0, 70.0, 75.0, 101.0, 93.0, 69.0, 88.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 87.0, 89.0, 132.0, 135.0, 101.0, 91.0, 87.0, 89.0, 87.0], "value": 99.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 94.0, 95.0, 101.0, 91.0, 155.0, 108.0, 103.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 91.0, 119.0, 86.0, 133.0, 133.0, 104.0, 147.0, 126.0, 72.0], "value": 111.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 75.0, 62.0, 60.0, 60.0, 66.0, 71.0, 59.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 91.0, 93.0, 100.0, 64.0, 84.0, 62.0, 96.0, 110.0, 106.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 84.0, 85.0, 84.0, 85.0, 83.0, 82.0, 85.0, 96.0, 81.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 139.0, 144.0, 147.0, 154.0, 160.0, 151.0, 248.0, 182.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 168.0, 167.0, 168.0, 165.0, 149.0, 225.0, 168.0, 165.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 67.0, 62.0, 77.0, 88.0, 77.0, 67.0, 65.0, 69.0], "value": 72.2, "unit": "score"}]}]} 03:33:22 INFO - Return code: 0 03:33:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:33:22 ERROR - # TBPL SUCCESS # 03:33:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:33:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:33:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:33:22 INFO - 2017-01-16 03:33:22.140 screenresolution[1826:11118] starting screenresolution argv=screenresolution get 03:33:22 INFO - 2017-01-16 03:33:22.144 screenresolution[1826:11118] Display 0: 1600x1200x32@60 03:33:22 INFO - 2017-01-16 03:33:22.151 screenresolution[1827:11121] starting screenresolution argv=screenresolution list 03:33:22 INFO - Available Modes on Display 0 03:33:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:33:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:33:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:33:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:33:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:33:22 INFO - Intel Iris: 03:33:22 INFO - Chipset Model: Intel Iris 03:33:22 INFO - Type: GPU 03:33:22 INFO - Bus: Built-In 03:33:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:33:22 INFO - Vendor: Intel (0x8086) 03:33:22 INFO - Device ID: 0x0a2e 03:33:22 INFO - Revision ID: 0x0009 03:33:22 INFO - Displays: 03:33:22 INFO - Display: 03:33:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:33:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:33:22 INFO - Display Serial Number: 1600x1200 60 03:33:22 INFO - Main Display: Yes 03:33:22 INFO - Mirror: Off 03:33:22 INFO - Online: Yes 03:33:22 INFO - Rotation: Supported 03:33:22 INFO - Return code: 0 03:33:22 INFO - Running post-action listener: _resource_record_post_action 03:33:22 INFO - [mozharness: 2017-01-16 11:33:22.393003Z] Finished run-tests step (success) 03:33:22 INFO - Running post-run listener: _resource_record_post_run 03:33:22 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33436160; Write bytes: 666693120; Read time: 202; Write time: 2029 03:33:22 INFO - TinderboxPrint: CPU usage
54.4% 03:33:22 INFO - TinderboxPrint: I/O read bytes / time
33,436,160 / 202 03:33:22 INFO - TinderboxPrint: I/O write bytes / time
666,693,120 / 2,029 03:33:22 INFO - TinderboxPrint: CPU idle
2,206.5 (45.6%) 03:33:22 INFO - TinderboxPrint: CPU system
980.0 (20.3%) 03:33:22 INFO - TinderboxPrint: CPU user
1,651.2 (34.1%) 03:33:22 INFO - TinderboxPrint: Swap in / out
378,634,240 / 0 03:33:22 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 346452480; Write bytes: 345863680; Read time: 26659; Write time: 742 03:33:22 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31363584; Write bytes: 313653248; Read time: 184; Write time: 1258 03:33:22 INFO - Running post-run listener: _upload_blobber_files 03:33:22 INFO - Blob upload gear active. 03:33:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:33:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:33:22 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'] 03:33:22 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 03:33:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:24 INFO - (blobuploader) - INFO - Done attempting. 03:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:25 INFO - (blobuploader) - INFO - Done attempting. 03:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:27 INFO - (blobuploader) - INFO - Done attempting. 03:33:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:33:27 INFO - Return code: 0 03:33:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:33:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:33:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1fdcd4a200db014f0b9cc8c5ed62f6f38df6dd2af7f85eba3fe11612790a6aa9c14c1465922f2dd22a6969dbee81fedc0f56d58583ee136f49df6296da8ba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba29d5255d4b8436dcdef95f4cd66334834d7514141c3cc77086099962db86710f77cbfe96828a09783d25ff7d6d365721856eb23ccb043b1d544dd627fb301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62328a6bf0474a23c473852e6dceba50da2beca4da75ec7529e40dd696123a26b639ee734f3dfc316c334b4dcbf60f4b8c416c876b9fdd5e3a1b137644d4d18"} 03:33:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:33:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:33:27 INFO - Contents: 03:33:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e1fdcd4a200db014f0b9cc8c5ed62f6f38df6dd2af7f85eba3fe11612790a6aa9c14c1465922f2dd22a6969dbee81fedc0f56d58583ee136f49df6296da8ba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba29d5255d4b8436dcdef95f4cd66334834d7514141c3cc77086099962db86710f77cbfe96828a09783d25ff7d6d365721856eb23ccb043b1d544dd627fb301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62328a6bf0474a23c473852e6dceba50da2beca4da75ec7529e40dd696123a26b639ee734f3dfc316c334b4dcbf60f4b8c416c876b9fdd5e3a1b137644d4d18"} 03:33:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:33:27 INFO - Copying logs to upload dir... 03:33:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:33:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.906242 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-01-16 03:33:27.246677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 03:33:27.250411) ========= 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.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/4e1fdcd4a200db014f0b9cc8c5ed62f6f38df6dd2af7f85eba3fe11612790a6aa9c14c1465922f2dd22a6969dbee81fedc0f56d58583ee136f49df6296da8ba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba29d5255d4b8436dcdef95f4cd66334834d7514141c3cc77086099962db86710f77cbfe96828a09783d25ff7d6d365721856eb23ccb043b1d544dd627fb301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62328a6bf0474a23c473852e6dceba50da2beca4da75ec7529e40dd696123a26b639ee734f3dfc316c334b4dcbf60f4b8c416c876b9fdd5e3a1b137644d4d18"} build_url:https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010936 build_url: 'https://queue.taskcluster.net/v1/task/Bw8LouRlTAaAFunGz-AD6w/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/4e1fdcd4a200db014f0b9cc8c5ed62f6f38df6dd2af7f85eba3fe11612790a6aa9c14c1465922f2dd22a6969dbee81fedc0f56d58583ee136f49df6296da8ba0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fba29d5255d4b8436dcdef95f4cd66334834d7514141c3cc77086099962db86710f77cbfe96828a09783d25ff7d6d365721856eb23ccb043b1d544dd627fb301", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c62328a6bf0474a23c473852e6dceba50da2beca4da75ec7529e40dd696123a26b639ee734f3dfc316c334b4dcbf60f4b8c416c876b9fdd5e3a1b137644d4d18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 03:33:27.285337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:33:27.285677) ========= 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.VyOb9M91MF/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.MFRdz6kMsB/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005012 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 03:33:27.335178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 03:33:27.335518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 03:33:27.335890) ========= ========= Total master_lag: 0.18 =========