builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0313 starttime: 1486750740.4 results: success (0) buildid: 20170210075621 builduid: 5814bc1a1a79465485b9d1568ecf2286 revision: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.402552) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.450077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.454104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.483816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.484219) ========= 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.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/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-02-10 10:19:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-02-10 10:19:00 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129761 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.641017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.641368) ========= 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.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/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.024701 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:00.689570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 10:19:00.692997) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 --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-beta --rev 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/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-02-10 10:19:00,770 truncating revision to first 12 chars 2017-02-10 10:19:00,770 Setting DEBUG logging. 2017-02-10 10:19:00,770 attempt 1/10 2017-02-10 10:19:00,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7d61a1453a97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 10:19:02,786 unpacking tar archive at: mozilla-beta-7d61a1453a97/testing/mozharness/ program finished with exit code 0 elapsedTime=2.294665 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 10:19:03.014173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:03.014510) ========= script_repo_revision: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:03.014916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:03.015202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 10:19:03.035478) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-10 10:19:03.036091) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:19:03 INFO - MultiFileLogger online at 20170210 10:19:03 in /builds/slave/test 10:19:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:19:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:19:03 INFO - {'append_to_log': False, 10:19:03 INFO - 'base_work_dir': '/builds/slave/test', 10:19:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:19:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:19:03 INFO - 'branch': 'Mozilla-Beta', 10:19:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:03 INFO - 'config_files': ('talos/mac_config.py',), 10:19:03 INFO - 'default_actions': ('clobber', 10:19:03 INFO - 'read-buildbot-config', 10:19:03 INFO - 'download-and-extract', 10:19:03 INFO - 'populate-webroot', 10:19:03 INFO - 'create-virtualenv', 10:19:03 INFO - 'install', 10:19:03 INFO - 'run-tests'), 10:19:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:03 INFO - 'download_minidump_stackwalk': True, 10:19:03 INFO - 'download_symbols': 'ondemand', 10:19:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:03 INFO - 'installer_path': 'installer.exe', 10:19:03 INFO - 'log_level': 'info', 10:19:03 INFO - 'log_name': 'talos', 10:19:03 INFO - 'log_to_console': True, 10:19:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:19:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:19:03 INFO - 'opt_config_files': (), 10:19:03 INFO - 'pip_index': False, 10:19:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:19:03 INFO - 'cmd': ('bash', 10:19:03 INFO - '-c', 10:19:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:19:03 INFO - 'enabled': True, 10:19:03 INFO - 'halt_on_failure': False, 10:19:03 INFO - 'name': 'check_screen_resolution'},), 10:19:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:19:03 INFO - 'cmd': ('bash', 10:19:03 INFO - '-c', 10:19:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:19:03 INFO - 'enabled': True, 10:19:03 INFO - 'halt_on_failure': False, 10:19:03 INFO - 'name': 'check_screen_resolution'},), 10:19:03 INFO - 'run_cmd_checks_enabled': True, 10:19:03 INFO - 'sps_profile': False, 10:19:03 INFO - 'sps_profile_interval': 0, 10:19:03 INFO - 'suite': 'dromaeojs-e10s', 10:19:03 INFO - 'system_bits': '32', 10:19:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:03 INFO - 'title': 't-yosemite-r7-0313', 10:19:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:03 INFO - 'use_talos_json': True, 10:19:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:19:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:03 INFO - 'work_dir': 'build'} 10:19:03 INFO - [mozharness: 2017-02-10 18:19:03.220113Z] Running clobber step. 10:19:03 INFO - Running pre-action listener: _resource_record_pre_action 10:19:03 INFO - Running main action method: clobber 10:19:03 INFO - rmtree: /builds/slave/test/build 10:19:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - [mozharness: 2017-02-10 18:19:05.650497Z] Finished clobber step (success) 10:19:05 INFO - [mozharness: 2017-02-10 18:19:05.650625Z] Running read-buildbot-config step. 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: read_buildbot_config 10:19:05 INFO - Using buildbot properties: 10:19:05 INFO - { 10:19:05 INFO - "project": "", 10:19:05 INFO - "product": "firefox", 10:19:05 INFO - "script_repo_revision": "production", 10:19:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:19:05 INFO - "repository": "", 10:19:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:19:05 INFO - "buildid": "20170210075621", 10:19:05 INFO - "pgo_build": "False", 10:19:05 INFO - "basedir": "/builds/slave/test", 10:19:05 INFO - "buildnumber": 31, 10:19:05 INFO - "slavename": "t-yosemite-r7-0313", 10:19:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:19:05 INFO - "platform": "yosemite_r7", 10:19:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:19:05 INFO - "branch": "mozilla-beta", 10:19:05 INFO - "repo_path": "releases/mozilla-beta", 10:19:05 INFO - "revision": "7d61a1453a97c1d74c5e702574fd5bf395e2bbf4", 10:19:05 INFO - "stage_platform": "macosx64", 10:19:05 INFO - "builduid": "5814bc1a1a79465485b9d1568ecf2286", 10:19:05 INFO - "slavebuilddir": "test" 10:19:05 INFO - } 10:19:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - [mozharness: 2017-02-10 18:19:05.653971Z] Finished read-buildbot-config step (success) 10:19:05 INFO - [mozharness: 2017-02-10 18:19:05.654105Z] Running download-and-extract step. 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: download_and_extract 10:19:05 INFO - mkdir: /builds/slave/test/build/tests 10:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:05 INFO - trying https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:19:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 10:19:07 INFO - Downloaded 1165 bytes. 10:19:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:19:07 INFO - Using the following test package requirements: 10:19:07 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:19:07 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:19:07 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:19:07 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:19:07 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:19:07 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:19:07 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:19:07 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:19:07 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:19:07 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:19:07 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:19:07 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:19:08 INFO - Http code: 200 10:19:08 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 10:19:08 INFO - x-amz-cf-id: BoNOU8Au__o57uoIni38q5tWsLELj7si5lpLg2xACuiSPIg7cIvT9g== 10:19:08 INFO - x-amz-version-id: mJIRzIGZdiuoeIzcBuJU4VMRVOKDZx.V 10:19:09 INFO - Expected file size: 16093666 10:19:09 INFO - Obtained file size: 16093666 10:19:15 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:19:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:19:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:19:15 INFO - Fetch https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:19:16 INFO - Http code: 200 10:19:16 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 10:19:16 INFO - x-amz-cf-id: _T5wRSKUQRPm4UW3XFLBb8bp6m4Pc2cklmnPFZiGIyw8W92b1YNALw== 10:19:16 INFO - x-amz-version-id: mJIRzIGZdiuoeIzcBuJU4VMRVOKDZx.V 10:19:18 INFO - Expected file size: 16093666 10:19:18 INFO - Obtained file size: 16093666 10:19:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:19:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:19:24 INFO - Fetch https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:19:25 INFO - Http code: 200 10:19:25 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 10:19:25 INFO - x-amz-cf-id: x10960QqSVIeq21S-4zEpfVd18bTOOdsvfYNIJJ0ea9wK_I6uq2wpg== 10:19:25 INFO - x-amz-version-id: CH0RwQTfWTow4ywClakIY4qWv6SlBU9W 10:19:26 INFO - Expected file size: 14403005 10:19:26 INFO - Obtained file size: 14403005 10:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:26 INFO - trying https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 10:19:35 INFO - Downloaded 82152816 bytes. 10:19:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:19:35 INFO - mkdir: /builds/slave/test/properties 10:19:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:35 INFO - Contents: 10:19:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:19:36 INFO - Running post-action listener: _resource_record_post_action 10:19:36 INFO - Running post-action listener: set_extra_try_arguments 10:19:36 INFO - [mozharness: 2017-02-10 18:19:36.705077Z] Finished download-and-extract step (success) 10:19:36 INFO - [mozharness: 2017-02-10 18:19:36.705201Z] Running populate-webroot step. 10:19:36 INFO - Running pre-action listener: _resource_record_pre_action 10:19:36 INFO - Running main action method: populate_webroot 10:19:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:36 INFO - '--tppagecycles', 10:19:36 INFO - '7'], 10:19:36 INFO - 'tests': ['tsvgm']}}, 10:19:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['damp', 'tps']}, 10:19:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'tests': ['damp', 'tps']}, 10:19:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['dromaeo_dom']}, 10:19:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['basic_compositor_video']}, 10:19:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['a11yr', 10:19:36 INFO - 'ts_paint', 10:19:36 INFO - 'tpaint', 10:19:36 INFO - 'sessionrestore', 10:19:36 INFO - 'sessionrestore_no_auto_restore', 10:19:36 INFO - 'tabpaint']}, 10:19:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['tsvgx', 10:19:36 INFO - 'tsvgr_opacity', 10:19:36 INFO - 'tart', 10:19:36 INFO - 'tscrollx', 10:19:36 INFO - 'cart']}, 10:19:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:36 INFO - 'tsvgr_opacity', 10:19:36 INFO - 'tart', 10:19:36 INFO - 'tscrollx', 10:19:36 INFO - 'cart']}, 10:19:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'talos_options': ['--disable-e10s'], 10:19:36 INFO - 'tests': ['tp5o']}, 10:19:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'tests': ['tp5o']}, 10:19:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'talos_options': ['--disable-e10s', 10:19:36 INFO - '--xperf_path', 10:19:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:36 INFO - 'tests': ['tp5n']}, 10:19:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:36 INFO - 'talos_options': ['--xperf_path', 10:19:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:36 INFO - 'tests': ['tp5n']}}, 10:19:36 INFO - 'talos.zip': {'path': '', 10:19:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:36 INFO - Running post-action listener: _resource_record_post_action 10:19:36 INFO - [mozharness: 2017-02-10 18:19:36.724114Z] Finished populate-webroot step (success) 10:19:36 INFO - [mozharness: 2017-02-10 18:19:36.724247Z] Running create-virtualenv step. 10:19:36 INFO - Running pre-action listener: _resource_record_pre_action 10:19:36 INFO - Running main action method: create_virtualenv 10:19:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:19:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:36 INFO - Using real prefix '/tools/python27' 10:19:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:37 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:40 INFO - Installing pip.................done. 10:19:40 INFO - Return code: 0 10:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:19:40 INFO - Reading from file tmpfile_stdout 10:19:40 INFO - Output received: 10:19:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:19:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:40 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:40 INFO - 'HOME': '/Users/cltbld', 10:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:40 INFO - 'LOGNAME': 'cltbld', 10:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:40 INFO - 'MOZ_NO_REMOTE': '1', 10:19:40 INFO - 'NO_EM_RESTART': '1', 10:19:40 INFO - 'PAGER': '/bin/cat', 10:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:40 INFO - 'PWD': '/builds/slave/test', 10:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:40 INFO - 'SHELL': '/bin/bash', 10:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:40 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:40 INFO - 'USER': 'cltbld', 10:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:40 INFO - 'XPC_FLAGS': '0x0', 10:19:40 INFO - 'XPC_SERVICE_NAME': '0', 10:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:19:40 INFO - Cleaning up... 10:19:40 INFO - Return code: 0 10:19:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:40 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:40 INFO - 'HOME': '/Users/cltbld', 10:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:40 INFO - 'LOGNAME': 'cltbld', 10:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:40 INFO - 'MOZ_NO_REMOTE': '1', 10:19:40 INFO - 'NO_EM_RESTART': '1', 10:19:40 INFO - 'PAGER': '/bin/cat', 10:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:40 INFO - 'PWD': '/builds/slave/test', 10:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:40 INFO - 'SHELL': '/bin/bash', 10:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:40 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:40 INFO - 'USER': 'cltbld', 10:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:40 INFO - 'XPC_FLAGS': '0x0', 10:19:40 INFO - 'XPC_SERVICE_NAME': '0', 10:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:41 INFO - Downloading/unpacking psutil>=3.1.1 10:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:44 INFO - Installing collected packages: psutil 10:19:44 INFO - Running setup.py install for psutil 10:19:44 INFO - building 'psutil._psutil_osx' extension 10:19:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:19:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:19:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:19:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:19:45 INFO - building 'psutil._psutil_posix' extension 10:19:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:19:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:19:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:19:45 INFO - ^ 10:19:45 INFO - 1 warning generated. 10:19:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:19:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:45 INFO - Successfully installed psutil 10:19:45 INFO - Cleaning up... 10:19:45 INFO - Return code: 0 10:19:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:19: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 mozsystemmonitor==0.3 10:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:45 INFO - 'HOME': '/Users/cltbld', 10:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:45 INFO - 'LOGNAME': 'cltbld', 10:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:45 INFO - 'MOZ_NO_REMOTE': '1', 10:19:45 INFO - 'NO_EM_RESTART': '1', 10:19:45 INFO - 'PAGER': '/bin/cat', 10:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:45 INFO - 'PWD': '/builds/slave/test', 10:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:45 INFO - 'SHELL': '/bin/bash', 10:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:45 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:45 INFO - 'USER': 'cltbld', 10:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:45 INFO - 'XPC_FLAGS': '0x0', 10:19:45 INFO - 'XPC_SERVICE_NAME': '0', 10:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:48 INFO - Installing collected packages: mozsystemmonitor 10:19:48 INFO - Running setup.py install for mozsystemmonitor 10:19:48 INFO - Successfully installed mozsystemmonitor 10:19:48 INFO - Cleaning up... 10:19:49 INFO - Return code: 0 10:19:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:49 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:19:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:49 INFO - 'HOME': '/Users/cltbld', 10:19:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:49 INFO - 'LOGNAME': 'cltbld', 10:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:49 INFO - 'MOZ_NO_REMOTE': '1', 10:19:49 INFO - 'NO_EM_RESTART': '1', 10:19:49 INFO - 'PAGER': '/bin/cat', 10:19:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:49 INFO - 'PWD': '/builds/slave/test', 10:19:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:49 INFO - 'SHELL': '/bin/bash', 10:19:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:49 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:49 INFO - 'USER': 'cltbld', 10:19:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:49 INFO - 'XPC_FLAGS': '0x0', 10:19:49 INFO - 'XPC_SERVICE_NAME': '0', 10:19:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:49 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:52 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:52 INFO - warning: no files found matching '*.txt' 10:19:52 INFO - no previously-included directories found matching 'build' 10:19:52 INFO - no previously-included directories found matching 'dist' 10:19:52 INFO - no previously-included directories found matching '.git*' 10:19:52 INFO - Installing collected packages: jsonschema, functools32 10:19:52 INFO - Running setup.py install for functools32 10:19:52 INFO - warning: no files found matching '*.txt' 10:19:52 INFO - no previously-included directories found matching 'build' 10:19:52 INFO - no previously-included directories found matching 'dist' 10:19:52 INFO - no previously-included directories found matching '.git*' 10:19:52 INFO - Successfully installed jsonschema functools32 10:19:52 INFO - Cleaning up... 10:19:52 INFO - Return code: 0 10:19:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', '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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:19: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 functools32==3.2.3-2 10:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:53 INFO - 'HOME': '/Users/cltbld', 10:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:53 INFO - 'LOGNAME': 'cltbld', 10:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:53 INFO - 'MOZ_NO_REMOTE': '1', 10:19:53 INFO - 'NO_EM_RESTART': '1', 10:19:53 INFO - 'PAGER': '/bin/cat', 10:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:53 INFO - 'PWD': '/builds/slave/test', 10:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:53 INFO - 'SHELL': '/bin/bash', 10:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:53 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:53 INFO - 'USER': 'cltbld', 10:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:53 INFO - 'XPC_FLAGS': '0x0', 10:19:53 INFO - 'XPC_SERVICE_NAME': '0', 10:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:53 INFO - Cleaning up... 10:19:53 INFO - Return code: 0 10:19:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:54 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:54 INFO - 'HOME': '/Users/cltbld', 10:19:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:54 INFO - 'LOGNAME': 'cltbld', 10:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:54 INFO - 'MOZ_NO_REMOTE': '1', 10:19:54 INFO - 'NO_EM_RESTART': '1', 10:19:54 INFO - 'PAGER': '/bin/cat', 10:19:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:54 INFO - 'PWD': '/builds/slave/test', 10:19:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:54 INFO - 'SHELL': '/bin/bash', 10:19:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:54 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:54 INFO - 'USER': 'cltbld', 10:19:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:54 INFO - 'XPC_FLAGS': '0x0', 10:19:54 INFO - 'XPC_SERVICE_NAME': '0', 10:19:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:58 INFO - Downloading docopt-0.6.1.tar.gz 10:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:58 INFO - Running setup.py install for blobuploader 10:19:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:58 INFO - Running setup.py install for requests 10:19:59 INFO - Running setup.py install for docopt 10:19:59 INFO - Successfully installed blobuploader requests docopt 10:19:59 INFO - Cleaning up... 10:19:59 INFO - Return code: 0 10:19:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:59 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:19:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:59 INFO - 'HOME': '/Users/cltbld', 10:19:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:59 INFO - 'LOGNAME': 'cltbld', 10:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:59 INFO - 'MOZ_NO_REMOTE': '1', 10:19:59 INFO - 'NO_EM_RESTART': '1', 10:19:59 INFO - 'PAGER': '/bin/cat', 10:19:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:59 INFO - 'PWD': '/builds/slave/test', 10:19:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:59 INFO - 'SHELL': '/bin/bash', 10:19:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:19:59 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:19:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:59 INFO - 'USER': 'cltbld', 10:19:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:59 INFO - 'XPC_FLAGS': '0x0', 10:19:59 INFO - 'XPC_SERVICE_NAME': '0', 10:19:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:59 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-S1jcpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-_Rbh5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-LyAYyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-aK7D5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-f_kCbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-uEvrWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-50iPRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-JK1Wlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-T5asNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:00 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-k4q9Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-JFtECb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-kcEgc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-xk7Ol5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-DNo5AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-oU6ij1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-FHw7Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:01 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-DCvQB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:01 INFO - Running setup.py install for manifestparser 10:20:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:20:01 INFO - Running setup.py install for mozcrash 10:20:02 INFO - Running setup.py install for mozdebug 10:20:02 INFO - Running setup.py install for mozdevice 10:20:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Running setup.py install for mozfile 10:20:02 INFO - Running setup.py install for mozhttpd 10:20:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Running setup.py install for mozinfo 10:20:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Running setup.py install for mozInstall 10:20:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:20:02 INFO - Running setup.py install for mozleak 10:20:03 INFO - Running setup.py install for mozlog 10:20:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Running setup.py install for moznetwork 10:20:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Running setup.py install for mozprocess 10:20:03 INFO - Running setup.py install for mozprofile 10:20:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Running setup.py install for mozrunner 10:20:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:20:03 INFO - Running setup.py install for mozscreenshot 10:20:03 INFO - Running setup.py install for moztest 10:20:04 INFO - Running setup.py install for mozversion 10:20:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:20:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:20:04 INFO - Cleaning up... 10:20:04 INFO - Return code: 0 10:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:04 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:20:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:20:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:04 INFO - 'HOME': '/Users/cltbld', 10:20:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:04 INFO - 'LOGNAME': 'cltbld', 10:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:04 INFO - 'MOZ_NO_REMOTE': '1', 10:20:04 INFO - 'NO_EM_RESTART': '1', 10:20:04 INFO - 'PAGER': '/bin/cat', 10:20:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:04 INFO - 'PWD': '/builds/slave/test', 10:20:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:04 INFO - 'SHELL': '/bin/bash', 10:20:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:20:04 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:20:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:04 INFO - 'USER': 'cltbld', 10:20:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:04 INFO - 'XPC_FLAGS': '0x0', 10:20:04 INFO - 'XPC_SERVICE_NAME': '0', 10:20:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:04 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-M0bqnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:04 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-kJiVis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:04 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-AWi169-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:04 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-pOzhGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-U94Jtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-gC1Iz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-ULYw6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-tjkJPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-uWXmMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-RrwIM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-TK26zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-VcinE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-6IG4mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:05 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-sihPQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:06 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-8pkW1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:06 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-X0mcQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:06 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)) 10:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:06 INFO - Running setup.py (path:/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/pip-I0xss_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:20:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:09 INFO - Downloading blessings-1.6.tar.gz 10:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:09 INFO - Installing collected packages: blessings 10:20:09 INFO - Running setup.py install for blessings 10:20:09 INFO - Successfully installed blessings 10:20:09 INFO - Cleaning up... 10:20:09 INFO - Return code: 0 10:20:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:09 INFO - Reading from file tmpfile_stdout 10:20:09 INFO - Current package versions: 10:20:09 INFO - blessings == 1.6 10:20:09 INFO - blobuploader == 1.2.4 10:20:09 INFO - docopt == 0.6.1 10:20:09 INFO - functools32 == 3.2.3-2 10:20:09 INFO - jsonschema == 2.5.1 10:20:09 INFO - manifestparser == 1.1 10:20:09 INFO - mozInstall == 1.12 10:20:09 INFO - mozcrash == 1.0 10:20:09 INFO - mozdebug == 0.1 10:20:09 INFO - mozdevice == 0.48 10:20:09 INFO - mozfile == 1.2 10:20:09 INFO - mozhttpd == 0.7 10:20:09 INFO - mozinfo == 0.9 10:20:09 INFO - mozleak == 0.1 10:20:09 INFO - mozlog == 3.4 10:20:09 INFO - moznetwork == 0.27 10:20:09 INFO - mozprocess == 0.23 10:20:09 INFO - mozprofile == 0.28 10:20:09 INFO - mozrunner == 6.13 10:20:09 INFO - mozscreenshot == 0.1 10:20:09 INFO - mozsystemmonitor == 0.3 10:20:09 INFO - moztest == 0.8 10:20:09 INFO - mozversion == 1.4 10:20:09 INFO - psutil == 3.1.1 10:20:09 INFO - requests == 1.2.3 10:20:09 INFO - wsgiref == 0.1.2 10:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:09 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:09 INFO - 'HOME': '/Users/cltbld', 10:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:09 INFO - 'LOGNAME': 'cltbld', 10:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:09 INFO - 'MOZ_NO_REMOTE': '1', 10:20:09 INFO - 'NO_EM_RESTART': '1', 10:20:09 INFO - 'PAGER': '/bin/cat', 10:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:09 INFO - 'PWD': '/builds/slave/test', 10:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:09 INFO - 'SHELL': '/bin/bash', 10:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:20:09 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:09 INFO - 'USER': 'cltbld', 10:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:09 INFO - 'XPC_FLAGS': '0x0', 10:20:09 INFO - 'XPC_SERVICE_NAME': '0', 10:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:20:09 INFO - Cleaning up... 10:20:09 INFO - Return code: 0 10:20:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:09 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 0x1036a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103616570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faad0e68590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, '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.obxiTX5Usg/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.vB3pRqYb5k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:20:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:20:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:09 INFO - 'HOME': '/Users/cltbld', 10:20:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:09 INFO - 'LOGNAME': 'cltbld', 10:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:09 INFO - 'MOZ_NO_REMOTE': '1', 10:20:09 INFO - 'NO_EM_RESTART': '1', 10:20:09 INFO - 'PAGER': '/bin/cat', 10:20:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:09 INFO - 'PWD': '/builds/slave/test', 10:20:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:09 INFO - 'SHELL': '/bin/bash', 10:20:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:20:09 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:20:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:09 INFO - 'USER': 'cltbld', 10:20:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:09 INFO - 'XPC_FLAGS': '0x0', 10:20:09 INFO - 'XPC_SERVICE_NAME': '0', 10:20:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:10 INFO - Cleaning up... 10:20:10 INFO - Return code: 0 10:20:10 INFO - Running post-action listener: _resource_record_post_action 10:20:10 INFO - Running post-action listener: _start_resource_monitoring 10:20:10 INFO - Starting resource monitoring. 10:20:10 INFO - [mozharness: 2017-02-10 18:20:10.246504Z] Finished create-virtualenv step (success) 10:20:10 INFO - [mozharness: 2017-02-10 18:20:10.247485Z] Running install step. 10:20:10 INFO - Running pre-action listener: _resource_record_pre_action 10:20:10 INFO - Running main action method: install 10:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:10 INFO - Reading from file tmpfile_stdout 10:20:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:10 INFO - Reading from file tmpfile_stdout 10:20:10 INFO - Output received: 10:20:10 INFO - Usage: mozinstall [options] installer 10:20:10 INFO - Options: 10:20:10 INFO - -h, --help show this help message and exit 10:20:10 INFO - -d DEST, --destination=DEST 10:20:10 INFO - Directory to install application into. [default: 10:20:10 INFO - "/builds/slave/test"] 10:20:10 INFO - --app=APP Application being installed. [default: firefox] 10:20:10 INFO - mkdir: /builds/slave/test/build/application 10:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:20:31 INFO - Reading from file tmpfile_stdout 10:20:31 INFO - Output received: 10:20:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:20:31 INFO - Running post-action listener: _resource_record_post_action 10:20:31 INFO - [mozharness: 2017-02-10 18:20:31.784885Z] Finished install step (success) 10:20:31 INFO - [mozharness: 2017-02-10 18:20:31.785045Z] Running run-tests step. 10:20:31 INFO - Running pre-action listener: _resource_record_pre_action 10:20:31 INFO - Running main action method: run_tests 10:20:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:31 INFO - 2017-02-10 10:20:31.799 screenresolution[1622:7383] starting screenresolution argv=screenresolution get 10:20:31 INFO - 2017-02-10 10:20:31.802 screenresolution[1622:7383] Display 0: 1600x1200x32@60 10:20:31 INFO - 2017-02-10 10:20:31.808 screenresolution[1623:7386] starting screenresolution argv=screenresolution list 10:20:31 INFO - Available Modes on Display 0 10:20:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:32 INFO - Intel Iris: 10:20:32 INFO - Chipset Model: Intel Iris 10:20:32 INFO - Type: GPU 10:20:32 INFO - Bus: Built-In 10:20:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:32 INFO - Vendor: Intel (0x8086) 10:20:32 INFO - Device ID: 0x0a2e 10:20:32 INFO - Revision ID: 0x0009 10:20:32 INFO - Displays: 10:20:32 INFO - Display: 10:20:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:32 INFO - Display Serial Number: 1600x1200 60 10:20:32 INFO - Main Display: Yes 10:20:32 INFO - Mirror: Off 10:20:32 INFO - Online: Yes 10:20:32 INFO - Rotation: Supported 10:20:32 INFO - Return code: 0 10:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:32 INFO - Python 2.7.3 10:20:32 INFO - Return code: 0 10:20:32 INFO - grabbing minidump binary from tooltool 10:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:32 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 0x1034b4d30>, '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 0x10331adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034acb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:20:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:20:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:20:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:32 INFO - Return code: 0 10:20:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:20:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:20:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0313', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0313 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:20:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.obxiTX5Usg/Render', 10:20:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:32 INFO - 'HOME': '/Users/cltbld', 10:20:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:32 INFO - 'LOGNAME': 'cltbld', 10:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:32 INFO - 'MOZ_NO_REMOTE': '1', 10:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:32 INFO - 'NO_EM_RESTART': '1', 10:20:32 INFO - 'PAGER': '/bin/cat', 10:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:32 INFO - 'PWD': '/builds/slave/test', 10:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:32 INFO - 'SHELL': '/bin/bash', 10:20:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vB3pRqYb5k/Listeners', 10:20:32 INFO - 'TMPDIR': '/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/', 10:20:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:32 INFO - 'USER': 'cltbld', 10:20:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:32 INFO - 'XPC_FLAGS': '0x0', 10:20:32 INFO - 'XPC_SERVICE_NAME': '0', 10:20:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0313', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:20:32 INFO - mozversion application_buildid: 20170210075621 10:20:32 INFO - mozversion application_changeset: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 10:20:32 INFO - mozversion application_display_name: Firefox 10:20:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:32 INFO - mozversion application_name: Firefox 10:20:32 INFO - mozversion application_remotingname: firefox 10:20:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:20:32 INFO - mozversion application_vendor: Mozilla 10:20:32 INFO - mozversion application_version: 52.0 10:20:32 INFO - mozversion platform_buildid: 20170210075621 10:20:32 INFO - mozversion platform_changeset: 7d61a1453a97c1d74c5e702574fd5bf395e2bbf4 10:20:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:20:32 INFO - mozversion platform_version: 52.0 10:20:32 INFO - using testdate: 1486750832 10:20:32 INFO - actual date: 1486750832 10:20:32 INFO - starting webserver on 'localhost:49248' 10:20:32 INFO - SUITE-START | Running 2 tests 10:20:32 INFO - TEST-START | dromaeo_css 10:20:32 INFO - operating with platform_type : mac_ 10:20:32 INFO - Initialising browser for dromaeo_css test... 10:20:32 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/tmpa_lyli/profile http://localhost:49248/getInfo.html) 10:20:35 INFO - PROCESS | 1633 | 2017-02-10 10:20:35.392 plugin-container[1636:7565] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 10:20:35 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:35 INFO - PROCESS | 1633 | 2017-02-10 10:20:35.392 plugin-container[1636:7565] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:20:35 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:35 INFO - PROCESS | 1633 | 2017-02-10 10:20:35.392 plugin-container[1636:7565] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:35 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 10:20:35 INFO - PROCESS | 1633 | colorDepth:24 10:20:35 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 10:20:35 INFO - PROCESS | 1633 | __metrics 10:20:35 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:20:36 INFO - TEST-INFO | 1633: exit 0 10:20:36 INFO - Browser initialized. 10:20:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:36 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/tmpa_lyli/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:38 INFO - PROCESS | 1637 | 2017-02-10 10:20:38.647 plugin-container[1638:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 10:20:38 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:38 INFO - PROCESS | 1637 | 2017-02-10 10:20:38.647 plugin-container[1638:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:20:38 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:38 INFO - PROCESS | 1637 | 2017-02-10 10:20:38.647 plugin-container[1638:7690] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:48 INFO - PROCESS | 1637 | RSS: Main: 177369088 10:20:48 INFO - PROCESS | 1637 | 10:23:50 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 10:23:52 INFO - PROCESS | 1637 | RSS: Main: 182968320 10:23:52 INFO - PROCESS | 1637 | 10:26:54 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 10:26:54 INFO - PROCESS | 1637 | RSS: Main: 193601536 10:26:54 INFO - PROCESS | 1637 | 10:29:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:29:57 INFO - PROCESS | 1637 | RSS: Main: 196399104 10:29:57 INFO - PROCESS | 1637 | 10:32:59 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:32:59 INFO - PROCESS | 1637 | RSS: Main: 199438336 10:32:59 INFO - PROCESS | 1637 | 10:36:02 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:36:03 INFO - PROCESS | 1637 | RSS: Main: 200822784 10:36:03 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:39:05 INFO - PROCESS | 1637 | RSS: Main: 200941568 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | __start_tp_report 10:39:05 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 10:39:05 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 10:39:05 INFO - PROCESS | 1637 | |i|pagename|runs| 10:39:05 INFO - PROCESS | 1637 | |0;dojo.html;2764.834109953402;3643.599204087551;3647.617000214979;3665.395209790385;3680.4111342185247;5972.19375384323;6022.638641681497;6104.816855494337;6126.693665316739;6155.261368635759;6087.756489740416;6174.629522228669;6207.162033125526;6208.6585237811905;6229.221347331583;5374.435684253156;5443.074677304848;5443.945560544384;5451.836444906639;5523.364813046491;5510.090835012218;5510.201020851974;5529.557635389159;5530.419305972875;5565.2486914266665;5349.277847490597;5393.164059570773;5479.6164268501225;5481;5497.202905578689;5428.240046393508;5454.372747134091;5457.263269458652;5463.918041229345;5468.043092458804;5301.787928482856;5408.4591540845995;5426.782928682848;5447.400785913546;5449.700266485342;6108.129596501707;6120.8738129976255;6122.79460843403;6139.890808645427;6180.598261113013;6268.373162683741;6389.520785941027;6424.357564243538;6430.839229019265;6450.419462248373;6486.124373209604;6489.5781774184525;6528.21661400635;6532.150820393366;6551.082848401227;6072.240969878765;6110.862540392742;6125.9693701531205;6135.417135372132;6208.286047104551;6619.304972977864;6658.134442522538;6658.201015878126;6666.200055993312;6678.599284042973;6306.936930630727;6332.556721029576;6335.11308416822;6337.302896681362;6338.714757835908;6301.243850737941;6347;6401.07184458251;6507.414332709984;6510.251321098134;5202.817901373433;6359.109724638554;6362.300146983828;6378.521610879203;6382.457491113215;6369.140166077613;6370.904436433365;6372.107904893319;6387.584806987624;6399.488040956712;4785.856424307276;5151.6908985461;5200.375954885362;5227.059129356752;5230.189320655304;4600.378948841863;4620.953790462119;4653.441587009581;4672.275797251432;4697.812087516461;6031.155638210654;6245.469135123474;6251.624902505773;6262.5616206866;6267.811965641038;4858.344123543347;6240.438360547572;6487.351264873475;6503.9349606504275;6509.837254068686;6093;6147.323794382614;6163.660998645118;6193.256809182927;6257.342978987232;5732.369439361667;5734.283214598176;5735.139729040678;5749.913751293734;5753.338366087954;5478.342598888159;6520.673966301761;6578.144841170617;6580.638064906476;6758.391744742997;6315.4947604192475;6445.355464453517;6471.838204044937;6493.577917435352;6510.31641677636;6703.966480167568;6712.362325579063;6714.294999025032;6721.529492935448;6745.156855393076;6205.565610407228;6252.968735156295;6340.714667839866;6398.296187419287;6430.067640192239;6373.171487706569;6427.935720642734;6453.225612926479;6481.5786973848435;6546.345365463416;6331.841703957438;6351.523635727246;6374.936250637435;6378.182218067828;6446.4520515756685;6122.081687746873;6288.182536270256;6338.461230795434;6353.745850165941;6355.396237357444;5754.942450575608;5899.144624029577;6116.42707509198;6134.467201660849;6220.222472190976;5220.7128607926925;6272.686365681607;6275.843103922439;6288.559800814082;6294.71673774672;6049.848753781191;6180.6600636965395;6238.313785483684;6243.344448832807;6243.96878015607 10:39:05 INFO - PROCESS | 1637 | |1;ext.html;502.62805523912306;518.9351331083615;527.3776943207014;528.801699362739;577.780443431496;33836.15409614758;40108.59891401085;41547.58452415475;41638.375424368656;41679.583204167946;42801.78599107;43814.34278485825;43877.7806110969;46120.538794612046;46138;9684.467354295512;9840.753981150458;9842.852357214648;9870.407775533491;9875.259355548327;9699.175570076552;9770.560324785401;9791.971842956495;9805.460699661517;9807.31348805584;8435.198656127657;9778.706638800812;9780;9799.804003919917;9813;9697.224222062217;9756.365836220622;9769.755756106084;9801.460919649417;9837.852432213558;8289.8342033159;9811.166050885684;9826.361286516425;9834.508274586313;9835.164011059069;41501.1699766006;41548;41767.32930682769;41808;41896.37155442671;3395.3442101074265;3406.2506248625264;3469.0633528947296;3478.89563313101;4125.690573207022;29105.70894291051;29855.701442985508;29912.8504357479;30161.396772064654;30928.762849485993;3347.364000839857;3361.781484203519;3418.4701371287492;3484.9825750871337;3485.721142308609;494818;494987;499541;502154;504599;63233.36766632367;63254.683726581075;63599;63628.72742545123;63871.6806415965;57854.13218801721;58482.707586461795;66607;66678;72074;14978.775318370233;17214.397496087826;17447.73828392575;17615;17806.198721057583;13389.933050334686;13523.729525409437;13529.864701353057;13549.119307245195;13572.728545429036;20255.696164557543;20617.793822061587;20734.963251837347;20790.960451977342;20888;7449.553026818408;7565.848683026308;8261.03470334243;8482.872756908651;8586.613602387908;866.8006358537446;927.8051609162152;1020.1889497849228;1056.1497994114811;1062.6068354708807;31013.224669383446;31150;31604.367912641617;31609.683903161134;31625.36749265048;921.3412410126791;1017.2777328096986;1054.9103326217205;1110.6723516562633;1124.1063354633086;16027;16134.193290335435;16164.676706465805;16211;16243.756343654855;563385;571787;572925;575365;575368;59498;59643;59800.700996494736;59868.70065649644;59871.40128598658;1201.4473342262481;1366.863313668625;1382.0740104130257;1401.3833913078417;1408.1199250468458;29698.960536381124;30345.601859901202;30472;30942.69057309398;31045.844770776002;51238.48761512337;51331.74334128306;51598.74200628973;51608.74195628998;51666;562229;564178;568621;569545;571550;28734.425311494073;29460;29475.852620736758;29688.960886368874;43362.69911902648;47607.76196118997;47666.28500572564;47844.76077619589;47951.76024119857;48004;32718.50922236121;39435.2112957745;39889.2022159561;41029.38455923223;41071.38392924049;33686.15784605405;39096.41355379728;39321.80339098286;39384.6061539381;40362.59637403706;29547.85226073942;39084.41373379459;39260.82217533478;39450.60549394469;39516.60483395129;26543;31981.36037279288;34414.31171376609;35513;35637;33108.33783324272;33439.83280083584;33533.82631607882;34449.31101378008;34462.48306275358 10:39:05 INFO - PROCESS | 1637 | |2;jquery.html;344.6295232624928;380.76392636565333;390.4241244164857;395.59451562148814;410.0384598117416;18980.715289270673;19137.138828752704;20417.795822041793;20451.693224601626;20630.793692063075;17427.390041348557;20308.883011434365;20492.795072049274;20632.793672063275;20717.721050684413;5292.782659988205;5706.3722990470915;5866.73599688015;5875.823725288248;5930.88138237235;5848.181254624356;5924.229850119478;5933.762649494015;5934.703264836762;5947.613405128653;5593.105103183491;5844.444777746107;5886.352501224862;5890.646561206341;5902.409759024106;5673.574481913832;5810.1865738796605;5810.970945145268;5836.328822185461;5848.385919478436;5008.323876276692;5023.171176755831;5091.745412729349;5111.207762796773;5117.82087626935;24863.5027299453;24934.50130997388;25256;25350;25403.61894571583;2284.348960546253;2300.919467818635;2425.34515680767;2555.3228394475477;2950.439416510856;14698.191599462025;15949.20253987296;16061.759073613905;16539.586510337216;16591.751123733153;1876.015092076657;1927.5181204698824;1947.7273181754565;1963.6759934610773;2028.2698228637678;115573;117594.41202793931;118765.40617296945;123260.76739232673;123371;11629;11679.941600291944;12018.939905300593;12084.274943503418;12119.757604847853;14883.404663813542;14918.209814822074;14940.701185976219;14944;14979.400823967137;8762.430442021248;8862.335324850663;8870.911290887008;8883.866741998876;8889.333300002525;8815.074417186232;8847.24798392131;8898.510581917928;8991.190792828676;8991.640334386551;3853.807309634507;4646;4653.86038418848;4667.346571479996;4672.2057250267535;1839.7884243311923;1989.3634037107986;2010.6380851446588;2018.6669199582198;2051.507638166859;854.3421565394611;867.1415298854089;924.2744445610164;930.042056681619;970.3062310448064;17140.485785426456;20960.895195523924;21313.467163320733;21771.45571360697;22084.11663533473;795.6697970342359;908.7319240823973;910.9205591374242;972.3193764364972;1006.4514839412537;10803.513841877135;11208.887911120948;11214.719632009102;11423.885761142283;11437;602198;609024;612033;612820;620472;131036.34481827721;133235;134386;137392;141429.8785518218;910.8497097978759;1009.5709323537467;1037.0510982451124;1044.2011860926398;1068.609957365556;18299.908500457947;18918.905405472884;19553.60892782165;19570.60858782788;19597.804021959597;43449;53230.73384633052;56079;58038.83922321614;58742;80675.386492271;82604.3479130426;83345.16654833374;84013.5799321024;88273.55863220643;8102.797430064295;8121.187881211831;8290;8456.577171141294;8542.316614670686;9127.863082053642;12606.432710527864;13271.469141234242;13275.86724132785;13331.466741330238;11115.610953616584;11357;11623.593174239199;11640.417979101181;11651.766964660828;9397.295202859676;11264.66206013821;11299.943500282447;11351.772964540498;11401.885981140082;11173.27373720738;11351.432428378383;11615.012723918562;11803.822942655695;11932.582359617372;8121.025476942568;8134.267915887362;8185.672573097248;8393;8589.012263589768;8254.54599997006;10570;11032;11241.044511216638;11294 10:39:05 INFO - PROCESS | 1637 | |3;mootools.html;1523.2155439948424;1553.1069634959897;1737.2008875917077;1800.702884024136;1855.7587513623218;7712.884306735389;7951.32413744831;8259.463134896236;8692.695755648554;8709.825803483927;8119.715809946653;8435.957820210906;8462.111478294783;8537.445066070717;8581.785455363619;2361.49227915998;2394.832361734679;2395.281415575329;2406.915757948472;2412.3969007748065;2365.7634236576378;2395.113807891074;2401.9639705404347;2404.843685160468;2422.1159276863905;2339.0059224829465;2352.7764862338136;2354.117206047732;2377.132346693453;2395.6406539019113;2084.6768750843644;2350.30665953545;2380.559596474649;2391.7249516305674;2400.8079353651665;2393.712754469457;2400.567897778399;2402.8678422686744;2422.321749910028;2425.163318655061;8523.914760852374;8582.485050896967;8603.139686031347;8625.482471051757;8664.826703465895;5228.032813929397;5389.9191512127345;5391.81128660495;5417.6207665463435;5418.674879507203;2918.781091418131;3456.3432947740102;3558.484019817138;3583.87456439026;3604.4232922732235;1058.0953284941418;1058.88352281249;1081.4808891732014;1099.19758576239;1117.6870476266577;11083.889161108447;11148.442577871156;11152.16358773087;11178.329300242012;11181.049610783093;4565.908681826345;4705.364775755298;4781;4785.306130611111;4825.155597770447;9656.565454554562;9662.855057174149;9663.082007209305;9708.077732615391;9737.977512361242;5321.920171197435;5324.707141107198;5325.307709997753;5339.81310654133;5345.01117293302;4008.3586626139677;4359.651227901761;4399.406080179199;4865.416150062015;4886.560209581155;3733.197362567061;3905.4727611772046;3972.1261322509004;3979.2837289287627;4036.6770658347264;1301.7982212757038;1313.8292022037074;1314.4019471140607;1317.637649646355;1322.1472150462898;830.2610676497922;860.7073594977612;932.5523748600709;936.9016253293306;965.6089283840056;5736.483716465538;5840.561957853178;5858.619189752652;5941.287045554561;6058.333583305921;441.15738938627067;457.2889157360337;459.9264117741145;463.28191303479474;466.0515850244736;3933.468981687493;3948.0524674078015;3972.7219094663674;4012.137390461065;4074.4499492568716;9895.554700038516;10038.548265328078;10356.689299321033;10405.635802746867;10435.217358698128;10052.69841904744;10299.3820370778;10326.86404495505;10340.844887326695;10347.482625868826;7898.763037108896;8015.679372825139;8027.478213916077;8078.959605202054;8109;5600.915986260128;5647.830565083054;5697.772089116389;5740.1102829061565;5909.70451477433;9240.584173712334;9410.106039926197;9456.763580910532;9504.95247523758;9695.806083878424;9320.533973301443;9560.235181185628;9560.330776845554;9613.471259080818;9737.853932191165;5589.245451863946;6949.965250173716;7169.749058782918;7412.481126321106;7490.063742032246;7986.800329991796;8122.7563173102535;8197.016358036835;8202.958985205036;8209.179082091743;7190.245024272585;7270.200277969525;7308.780736577911;7396.852062958818;7459.850802983801;7121.038659780863;7122.537035092702;7145.4998150128995;7156.463265255231;7175.067241258603;6722.9663851680425;6849.623270720158;6855.760048398282;6858.2455929848675;6861.588304701734;4880.487548807324;4929.753512324298;4951.430585482572;5022.949770502249;5051.974740126423;5001.149804533311;5001.474845141353;5041.621878359065;5072.746362681925;5092.439831618445 10:39:05 INFO - PROCESS | 1637 | |4;prototype.html;295.4873294833464;310.9642391125021;323.17912502244303;325.4012616785115;326.6309070750052;4769.856904292868;5247.396549396821;5361.651492652984;5480.835574932748;5508.980838544872;3973.086190176261;4388.824447022115;4969.5030496950285;5399.9730001349935;5500.669959802414;3182.6976437238427;4116.464859568259;4176.749395036292;4234.1955028544635;4248.638865696419;3511.824408779564;3845.788481633509;3864.3237433449035;4006.0325196755957;4175.603317684815;3367.2423704666376;4043.07009387841;4054.209429161315;4078.7159190853067;4092.89767755807;3728.527231743446;3874.8256328465286;4056.675465962716;4066.3087275163293;4080.8163632636456;3576.6065732769375;3584.4623306503972;3585.0858031202138;3596.8021758803256;3599.4780756790383;4340.978295108536;4975.975120124413;5281.683099014072;5327;5399.488143319877;4709.411323584552;4720.858374248778;4727.338172655831;4732.621390288768;4733.5976442002475;4991.950080499221;5704.377720147694;5760.82717518471;5784.409287445944;5809.390014048507;3298.526105420934;3475.8088305143206;3675.9264814703556;3691.280200360931;3932.233214523169;5210.557102646279;5964.552658550582;6066.696665166768;6100.23747031621;6124.234470691164;3997.620226078518;4008.579099194601;4022;4023;4050.8379664813665;3714.257148570297;3783.5270591176104;4065.166640838621;4087.4073259377224;4115.238680843993;4684.81260749573;4704.388429504143;4710.599599034121;4731.905361892743;4786.664933454695;5064.987002599495;5845.655499235115;5876.353601103875;5895.263092113486;5915.49154965481;1288.7035981724257;1319.7426501832051;1320.3662242123835;1338.377654390713;1343.8320209973754;782.7299581644323;815.176671561727;888.4003297773977;894.874717539545;907.2968449451728;4994.126027945168;5243.68537887728;5259.63182577216;5268.631195816332;5314.671332166959;5138.409082955433;5726.541876649858;5730.971345143247;5757.337906140848;5785.450382213683;4692.451491008027;4804.471508134103;4947.330578797233;5217.217417387422;5226.869328266747;2573.84556926585;2938.4563855686765;3002.2944608017096;3008.4283986042583;3014.457397668397;5371.677699338053;5625.943740562542;5669.8943705976935;5719.710217336998;5992.520598352121;5470.56235501159;5669.716514174274;5811.651300921958;5816.331121920949;5916.8462149881225;5689.601727879009;5965.55258355625;5965.582409231399;5968.8806223876145;5975.028240680565;5598.356189038313;5728.598998070095;5730.194988578584;5737.762272713561;5744.569157313134;5664.320281566238;6006.48944839676;6043.12374705674;6052.878942421215;6086.69566521681;5088.54203121706;6328.392816094782;6349.238091428873;6377.2984971654005;6393.073004414427;3872.76763394186;3951.42704307868;3965.524137103566;3986.8405263789123;3990.620891015465;5152.871178220575;5751.447109280387;5780.21967034445;6047.516198704181;6053.303870054824;4697.060587882505;4959.479254678351;5476.589255805751;5779.092899343291;5823.82528524145;5931.169636250842;5931.881362372642;5940.316863560746;5945.929732648165;5963.4334738199805;4611.423572053493;5668.858278543069;5805.477507024388;5848.502877255481;5883.823485295448;5450.427705091067;5910.822675319575;5921.437463440966;5925.555583331181;6016.398360163948;5488.670679759227;5791.623544469596;5829.504492118217;5912.940870591411;5927.318358388668 10:39:05 INFO - PROCESS | 1637 | |5;yui.html;660.4254298760079;744.2297222374843;761.4859969520572;794.1145622630764;817.5340056167983;12990.610281691552;14603.634909127277;14919.254037298133;15420.61448463789;15545.222738863069;11938.880611193885;14030.719385612281;14095.083819551748;14169.71660566788;14215.71568568628;828.9336853051757;861.0528418739368;862.560094351882;862.7282406042077;864.2222000199807;824.2087595907906;859.7721603775004;862.6980556805099;864.9481031138121;866.5493943149559;901.9323550733689;914.085914085914;914.7804526913526;915.2906497464452;916.1754421021101;893.2452077994085;897.2911399993997;907.5054095517926;907.5144797533288;911.9817603647956;661.7452280871898;677.4715721737053;677.986410316575;681.8840797064511;682.0553533356288;14563.490277840225;14854.331555080047;14871.47949821751;14937.626559335995;15288.082715037022;13606.455741770318;13648.454061837514;13947.45570566486;13984.230867302294;14007.929960350235;11472.94263528677;11613.669362685161;11799.351035693033;11905;11981.400929953556;3727.310447567209;3757.8684746034032;3769.2838360711376;3770.057485628593;3782.470454136423;74730;95206.0479395211;95795.56306655335;102049.48975255151;102862.42843928962;9290.581923813445;10383.037003587757;10661.733456663645;10662.147028237878;10704.732381690521;19462.610747784965;20205.49486262855;20236.89881550583;20965.895170524356;21086.683699744517;7969;7970.561619111005;8148.348132149414;8175.877361839577;8286.839842422065;3816.5420149581673;4399.36209249657;4479;4524.02733412318;4605.148047611203;3400.302937897725;3471.114865709228;3477.2523907360037;3514.683678468899;3515.648435156515;636.8312397214742;641.8097450093911;645.8482256669679;661.8146918862726;665.3180489997694;606.6572386601556;635.291649810458;638.581728967527;645.7191121861911;683.6069260175319;8731.432456890281;9241.306901982378;9338.579763910504;9428.717138485856;9677.161339345503;553.6788662575697;613.3375953969702;652.9846089331136;663.2339647706906;698.1447726534954;4259.893502662459;4297.8495752648505;4571.22289210835;4626.444826620827;4627.421572303462;82146.58926705328;102831;103207;107859.92140078655;112465;90903;93393.53303233441;96054;96769;97402.5129874346;83932;87822.80442988849;88907.55546222356;89723.55138224267;89759.55120224357;6941.687624056828;8729.127087291221;8913;9044.14080662336;9351.53242337894;58889;59317;59368.109478358725;59565;60572.78854422799;81807.59096204481;83291;83891;84018.15981840104;84700.30599387854;11398.953470527322;11501;11671.241369310968;11731.530738770694;11859.34773587461;12628.684282892633;12742.299173545172;12849.03632227568;13118.409671564994;13149.145305555108;11813.704657383634;11890.643280701594;12009.699757506132;12050.758984820079;12187.51249949992;11082.390468524309;11864.466099025738;11926;11964;12008.63974080779;11771.52913883435;11912.808719128017;11923.84018235151;12000.459979300778;12084.637460876187;10321.845172322572;10620.309679870783;10636.149108071491;10673.41296228715;10818.29681070728;10431;10443;10602.045815876609;10624.575016999233;10640.89359106399 10:39:05 INFO - PROCESS | 1637 | __end_tp_report 10:39:05 INFO - PROCESS | 1637 | __start_cc_report 10:39:05 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,364 10:39:05 INFO - PROCESS | 1637 | __end_cc_report 10:39:05 INFO - PROCESS | 1637 | __startTimestamp1486751945801__endTimestamp 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | ------- Summary: start ------- 10:39:05 INFO - PROCESS | 1637 | Number of tests: 6 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5982.00 Median:6229.22 stddev:669.02 (10.7%) stddev-sans-first:621.65 10:39:05 INFO - PROCESS | 1637 | Values: 2764.8 3643.6 3647.6 3665.4 3680.4 5972.2 6022.6 6104.8 6126.7 6155.3 6087.8 6174.6 6207.2 6208.7 6229.2 5374.4 5443.1 5443.9 5451.8 5523.4 5510.1 5510.2 5529.6 5530.4 5565.2 5349.3 5393.2 5479.6 5481.0 5497.2 5428.2 5454.4 5457.3 5463.9 5468.0 5301.8 5408.5 5426.8 5447.4 5449.7 6108.1 6120.9 6122.8 6139.9 6180.6 6268.4 6389.5 6424.4 6430.8 6450.4 6486.1 6489.6 6528.2 6532.2 6551.1 6072.2 6110.9 6126.0 6135.4 6208.3 6619.3 6658.1 6658.2 6666.2 6678.6 6306.9 6332.6 6335.1 6337.3 6338.7 6301.2 6347.0 6401.1 6507.4 6510.3 5202.8 6359.1 6362.3 6378.5 6382.5 6369.1 6370.9 6372.1 6387.6 6399.5 4785.9 5151.7 5200.4 5227.1 5230.2 4600.4 4621.0 4653.4 4672.3 4697.8 6031.2 6245.5 6251.6 6262.6 6267.8 4858.3 6240.4 6487.4 6503.9 6509.8 6093.0 6147.3 6163.7 6193.3 6257.3 5732.4 5734.3 5735.1 5749.9 5753.3 5478.3 6520.7 6578.1 6580.6 6758.4 6315.5 6445.4 6471.8 6493.6 6510.3 6704.0 6712.4 6714.3 6721.5 6745.2 6205.6 6253.0 6340.7 6398.3 6430.1 6373.2 6427.9 6453.2 6481.6 6546.3 6331.8 6351.5 6374.9 6378.2 6446.5 6122.1 6288.2 6338.5 6353.7 6355.4 5754.9 5899.1 6116.4 6134.5 6220.2 5220.7 6272.7 6275.8 6288.6 6294.7 6049.8 6180.7 6238.3 6243.3 6244.0 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69196.66 Median:41593.19 stddev:145684.89 (350.3%) stddev-sans-first:146002.28 10:39:05 INFO - PROCESS | 1637 | Values: 502.6 518.9 527.4 528.8 577.8 33836.2 40108.6 41547.6 41638.4 41679.6 42801.8 43814.3 43877.8 46120.5 46138.0 9684.5 9840.8 9842.9 9870.4 9875.3 9699.2 9770.6 9792.0 9805.5 9807.3 8435.2 9778.7 9780.0 9799.8 9813.0 9697.2 9756.4 9769.8 9801.5 9837.9 8289.8 9811.2 9826.4 9834.5 9835.2 41501.2 41548.0 41767.3 41808.0 41896.4 3395.3 3406.3 3469.1 3478.9 4125.7 29105.7 29855.7 29912.9 30161.4 30928.8 3347.4 3361.8 3418.5 3485.0 3485.7 494818.0 494987.0 499541.0 502154.0 504599.0 63233.4 63254.7 63599.0 63628.7 63871.7 57854.1 58482.7 66607.0 66678.0 72074.0 14978.8 17214.4 17447.7 17615.0 17806.2 13389.9 13523.7 13529.9 13549.1 13572.7 20255.7 20617.8 20735.0 20791.0 20888.0 7449.6 7565.8 8261.0 8482.9 8586.6 866.8 927.8 1020.2 1056.1 1062.6 31013.2 31150.0 31604.4 31609.7 31625.4 921.3 1017.3 1054.9 1110.7 1124.1 16027.0 16134.2 16164.7 16211.0 16243.8 563385.0 571787.0 572925.0 575365.0 575368.0 59498.0 59643.0 59800.7 59868.7 59871.4 1201.4 1366.9 1382.1 1401.4 1408.1 29699.0 30345.6 30472.0 30942.7 31045.8 51238.5 51331.7 51598.7 51608.7 51666.0 562229.0 564178.0 568621.0 569545.0 571550.0 28734.4 29460.0 29475.9 29689.0 43362.7 47607.8 47666.3 47844.8 47951.8 48004.0 32718.5 39435.2 39889.2 41029.4 41071.4 33686.2 39096.4 39321.8 39384.6 40362.6 29547.9 39084.4 39260.8 39450.6 39516.6 26543.0 31981.4 34414.3 35513.0 35637.0 33108.3 33439.8 33533.8 34449.3 34462.5 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:36020.13 Median:24899.00 stddev:102185.71 (410.4%) stddev-sans-first:102437.26 10:39:05 INFO - PROCESS | 1637 | Values: 344.6 380.8 390.4 395.6 410.0 18980.7 19137.1 20417.8 20451.7 20630.8 17427.4 20308.9 20492.8 20632.8 20717.7 5292.8 5706.4 5866.7 5875.8 5930.9 5848.2 5924.2 5933.8 5934.7 5947.6 5593.1 5844.4 5886.4 5890.6 5902.4 5673.6 5810.2 5811.0 5836.3 5848.4 5008.3 5023.2 5091.7 5111.2 5117.8 24863.5 24934.5 25256.0 25350.0 25403.6 2284.3 2300.9 2425.3 2555.3 2950.4 14698.2 15949.2 16061.8 16539.6 16591.8 1876.0 1927.5 1947.7 1963.7 2028.3 115573.0 117594.4 118765.4 123260.8 123371.0 11629.0 11679.9 12018.9 12084.3 12119.8 14883.4 14918.2 14940.7 14944.0 14979.4 8762.4 8862.3 8870.9 8883.9 8889.3 8815.1 8847.2 8898.5 8991.2 8991.6 3853.8 4646.0 4653.9 4667.3 4672.2 1839.8 1989.4 2010.6 2018.7 2051.5 854.3 867.1 924.3 930.0 970.3 17140.5 20960.9 21313.5 21771.5 22084.1 795.7 908.7 910.9 972.3 1006.5 10803.5 11208.9 11214.7 11423.9 11437.0 602198.0 609024.0 612033.0 612820.0 620472.0 131036.3 133235.0 134386.0 137392.0 141429.9 910.8 1009.6 1037.1 1044.2 1068.6 18299.9 18918.9 19553.6 19570.6 19597.8 43449.0 53230.7 56079.0 58038.8 58742.0 80675.4 82604.3 83345.2 84013.6 88273.6 8102.8 8121.2 8290.0 8456.6 8542.3 9127.9 12606.4 13271.5 13275.9 13331.5 11115.6 11357.0 11623.6 11640.4 11651.8 9397.3 11264.7 11299.9 11351.8 11401.9 11173.3 11351.4 11615.0 11803.8 11932.6 8121.0 8134.3 8185.7 8393.0 8589.0 8254.5 10570.0 11032.0 11241.0 11294.0 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5563.02 Median:5046.80 stddev:3058.41 (60.6%) stddev-sans-first:3051.92 10:39:05 INFO - PROCESS | 1637 | Values: 1523.2 1553.1 1737.2 1800.7 1855.8 7712.9 7951.3 8259.5 8692.7 8709.8 8119.7 8436.0 8462.1 8537.4 8581.8 2361.5 2394.8 2395.3 2406.9 2412.4 2365.8 2395.1 2402.0 2404.8 2422.1 2339.0 2352.8 2354.1 2377.1 2395.6 2084.7 2350.3 2380.6 2391.7 2400.8 2393.7 2400.6 2402.9 2422.3 2425.2 8523.9 8582.5 8603.1 8625.5 8664.8 5228.0 5389.9 5391.8 5417.6 5418.7 2918.8 3456.3 3558.5 3583.9 3604.4 1058.1 1058.9 1081.5 1099.2 1117.7 11083.9 11148.4 11152.2 11178.3 11181.0 4565.9 4705.4 4781.0 4785.3 4825.2 9656.6 9662.9 9663.1 9708.1 9738.0 5321.9 5324.7 5325.3 5339.8 5345.0 4008.4 4359.7 4399.4 4865.4 4886.6 3733.2 3905.5 3972.1 3979.3 4036.7 1301.8 1313.8 1314.4 1317.6 1322.1 830.3 860.7 932.6 936.9 965.6 5736.5 5840.6 5858.6 5941.3 6058.3 441.2 457.3 459.9 463.3 466.1 3933.5 3948.1 3972.7 4012.1 4074.4 9895.6 10038.5 10356.7 10405.6 10435.2 10052.7 10299.4 10326.9 10340.8 10347.5 7898.8 8015.7 8027.5 8079.0 8109.0 5600.9 5647.8 5697.8 5740.1 5909.7 9240.6 9410.1 9456.8 9505.0 9695.8 9320.5 9560.2 9560.3 9613.5 9737.9 5589.2 6950.0 7169.7 7412.5 7490.1 7986.8 8122.8 8197.0 8203.0 8209.2 7190.2 7270.2 7308.8 7396.9 7459.9 7121.0 7122.5 7145.5 7156.5 7175.1 6723.0 6849.6 6855.8 6858.2 6861.6 4880.5 4929.8 4951.4 5022.9 5052.0 5001.1 5001.5 5041.6 5072.7 5092.4 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4648.07 Median:5235.28 stddev:1463.04 (27.9%) stddev-sans-first:1430.20 10:39:05 INFO - PROCESS | 1637 | Values: 295.5 311.0 323.2 325.4 326.6 4769.9 5247.4 5361.7 5480.8 5509.0 3973.1 4388.8 4969.5 5400.0 5500.7 3182.7 4116.5 4176.7 4234.2 4248.6 3511.8 3845.8 3864.3 4006.0 4175.6 3367.2 4043.1 4054.2 4078.7 4092.9 3728.5 3874.8 4056.7 4066.3 4080.8 3576.6 3584.5 3585.1 3596.8 3599.5 4341.0 4976.0 5281.7 5327.0 5399.5 4709.4 4720.9 4727.3 4732.6 4733.6 4992.0 5704.4 5760.8 5784.4 5809.4 3298.5 3475.8 3675.9 3691.3 3932.2 5210.6 5964.6 6066.7 6100.2 6124.2 3997.6 4008.6 4022.0 4023.0 4050.8 3714.3 3783.5 4065.2 4087.4 4115.2 4684.8 4704.4 4710.6 4731.9 4786.7 5065.0 5845.7 5876.4 5895.3 5915.5 1288.7 1319.7 1320.4 1338.4 1343.8 782.7 815.2 888.4 894.9 907.3 4994.1 5243.7 5259.6 5268.6 5314.7 5138.4 5726.5 5731.0 5757.3 5785.5 4692.5 4804.5 4947.3 5217.2 5226.9 2573.8 2938.5 3002.3 3008.4 3014.5 5371.7 5625.9 5669.9 5719.7 5992.5 5470.6 5669.7 5811.7 5816.3 5916.8 5689.6 5965.6 5965.6 5968.9 5975.0 5598.4 5728.6 5730.2 5737.8 5744.6 5664.3 6006.5 6043.1 6052.9 6086.7 5088.5 6328.4 6349.2 6377.3 6393.1 3872.8 3951.4 3965.5 3986.8 3990.6 5152.9 5751.4 5780.2 6047.5 6053.3 4697.1 4959.5 5476.6 5779.1 5823.8 5931.2 5931.9 5940.3 5945.9 5963.4 4611.4 5668.9 5805.5 5848.5 5883.8 5450.4 5910.8 5921.4 5925.6 6016.4 5488.7 5791.6 5829.5 5912.9 5927.3 10:39:05 INFO - PROCESS | 1637 | 10:39:05 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20883.57 Median:4547.63 stddev:30697.45 (675.0%) stddev-sans-first:30746.01 10:39:05 INFO - PROCESS | 1637 | Values: 660.4 744.2 761.5 794.1 817.5 12990.6 14603.6 14919.3 15420.6 15545.2 11938.9 14030.7 14095.1 14169.7 14215.7 828.9 861.1 862.6 862.7 864.2 824.2 859.8 862.7 864.9 866.5 901.9 914.1 914.8 915.3 916.2 893.2 897.3 907.5 907.5 912.0 661.7 677.5 678.0 681.9 682.1 14563.5 14854.3 14871.5 14937.6 15288.1 13606.5 13648.5 13947.5 13984.2 14007.9 11472.9 11613.7 11799.4 11905.0 11981.4 3727.3 3757.9 3769.3 3770.1 3782.5 74730.0 95206.0 95795.6 102049.5 102862.4 9290.6 10383.0 10661.7 10662.1 10704.7 19462.6 20205.5 20236.9 20965.9 21086.7 7969.0 7970.6 8148.3 8175.9 8286.8 3816.5 4399.4 4479.0 4524.0 4605.1 3400.3 3471.1 3477.3 3514.7 3515.6 636.8 641.8 645.8 661.8 665.3 606.7 635.3 638.6 645.7 683.6 8731.4 9241.3 9338.6 9428.7 9677.2 553.7 613.3 653.0 663.2 698.1 4259.9 4297.8 4571.2 4626.4 4627.4 82146.6 102831.0 103207.0 107859.9 112465.0 90903.0 93393.5 96054.0 96769.0 97402.5 83932.0 87822.8 88907.6 89723.6 89759.6 6941.7 8729.1 8913.0 9044.1 9351.5 58889.0 59317.0 59368.1 59565.0 60572.8 81807.6 83291.0 83891.0 84018.2 84700.3 11399.0 11501.0 11671.2 11731.5 11859.3 12628.7 12742.3 12849.0 13118.4 13149.1 11813.7 11890.6 12009.7 12050.8 12187.5 11082.4 11864.5 11926.0 11964.0 12008.6 11771.5 11912.8 11923.8 12000.5 12084.6 10321.8 10620.3 10636.1 10673.4 10818.3 10431.0 10443.0 10602.0 10624.6 10640.9 10:39:05 INFO - PROCESS | 1637 | -------- Summary: end -------- 10:39:05 INFO - PROCESS | 1637 | 10:39:06 INFO - TEST-INFO | 1637: exit 0 10:39:06 INFO - TEST-OK | dromaeo_css | took 1113978ms 10:39:06 INFO - TEST-START | kraken 10:39:06 INFO - operating with platform_type : mac_ 10:39:06 INFO - Initialising browser for kraken test... 10:39:06 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/tmps_Tj8m/profile http://localhost:49248/getInfo.html) 10:39:09 INFO - PROCESS | 1649 | 2017-02-10 10:39:08.999 plugin-container[1651:9943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 10:39:09 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:09 INFO - PROCESS | 1649 | 2017-02-10 10:39:09.000 plugin-container[1651:9943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0f, name = 'com.apple.CFPasteboardClient' 10:39:09 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:09 INFO - PROCESS | 1649 | 2017-02-10 10:39:09.000 plugin-container[1651:9943] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:39:09 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 10:39:09 INFO - PROCESS | 1649 | colorDepth:24 10:39:09 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 10:39:09 INFO - PROCESS | 1649 | __metrics 10:39:09 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:39:10 INFO - TEST-INFO | 1649: exit 0 10:39:10 INFO - Browser initialized. 10:39:10 INFO - Running cycle 1/1 for kraken test... 10:39:10 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/T/tmps_Tj8m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:12 INFO - PROCESS | 1652 | 2017-02-10 10:39:12.496 plugin-container[1653:10068] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x854b, name = 'com.apple.tsm.portname' 10:39:12 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:12 INFO - PROCESS | 1652 | 2017-02-10 10:39:12.497 plugin-container[1653:10068] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b17, name = 'com.apple.CFPasteboardClient' 10:39:12 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:39:12 INFO - PROCESS | 1652 | 2017-02-10 10:39:12.497 plugin-container[1653:10068] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:39:22 INFO - PROCESS | 1652 | RSS: Main: 177217536 10:39:22 INFO - PROCESS | 1652 | 10:39:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:26 INFO - PROCESS | 1652 | RSS: Main: 190275584 10:39:26 INFO - PROCESS | 1652 | 10:39:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:39:29 INFO - PROCESS | 1652 | RSS: Main: 198254592 10:39:29 INFO - PROCESS | 1652 | 10:39:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:39:33 INFO - PROCESS | 1652 | RSS: Main: 202100736 10:39:33 INFO - PROCESS | 1652 | 10:39:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:39:35 INFO - PROCESS | 1652 | RSS: Main: 202280960 10:39:35 INFO - PROCESS | 1652 | 10:39:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:38 INFO - PROCESS | 1652 | RSS: Main: 203649024 10:39:38 INFO - PROCESS | 1652 | 10:39:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:41 INFO - PROCESS | 1652 | RSS: Main: 207544320 10:39:41 INFO - PROCESS | 1652 | 10:39:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:45 INFO - PROCESS | 1652 | RSS: Main: 207912960 10:39:45 INFO - PROCESS | 1652 | 10:39:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:39:49 INFO - PROCESS | 1652 | RSS: Main: 207175680 10:39:49 INFO - PROCESS | 1652 | 10:39:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:51 INFO - PROCESS | 1652 | RSS: Main: 206196736 10:39:51 INFO - PROCESS | 1652 | 10:39:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:53 INFO - PROCESS | 1652 | RSS: Main: 206450688 10:39:53 INFO - PROCESS | 1652 | 10:39:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:56 INFO - PROCESS | 1652 | RSS: Main: 205926400 10:39:56 INFO - PROCESS | 1652 | 10:39:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:00 INFO - PROCESS | 1652 | RSS: Main: 206123008 10:40:00 INFO - PROCESS | 1652 | 10:40:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:03 INFO - PROCESS | 1652 | RSS: Main: 206295040 10:40:03 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:40:05 INFO - PROCESS | 1652 | RSS: Main: 208064512 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | __start_tp_report 10:40:05 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:40:05 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:40:05 INFO - PROCESS | 1652 | |i|pagename|runs| 10:40:05 INFO - PROCESS | 1652 | |0;ai-astar;106;116;134;172;161;117;125;172;171;95 10:40:05 INFO - PROCESS | 1652 | |1;audio-beat-detection;139;110;114;143;111;114;111;115;171;141 10:40:05 INFO - PROCESS | 1652 | |2;audio-dft;199;193;196;197;194;193;195;193;197;194 10:40:05 INFO - PROCESS | 1652 | |3;audio-fft;81;59;58;80;59;61;58;59;87;67 10:40:05 INFO - PROCESS | 1652 | |4;audio-oscillator;87;69;86;71;68;69;99;99;71;84 10:40:05 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;87;88;84;88;80;88;82;136;86 10:40:05 INFO - PROCESS | 1652 | |6;imaging-darkroom;103;96;148;150;139;93;121;94;94;95 10:40:05 INFO - PROCESS | 1652 | |7;imaging-desaturate;87;88;105;121;140;86;89;88;89;89 10:40:05 INFO - PROCESS | 1652 | |8;json-parse-financial;57;55;56;56;59;57;59;60;59;61 10:40:05 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;67;73;68;73;66;66;69;69;69;71 10:40:05 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;87;101;77;93;102;105;84;88;86;84 10:40:05 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;159;130;149;155;160;137;137;151;204;179 10:40:05 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;166;165;166;169;168;164;174;224;166;162 10:40:05 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;66;69;68;66;69;66;66;65;66 10:40:05 INFO - PROCESS | 1652 | __end_tp_report 10:40:05 INFO - PROCESS | 1652 | __start_cc_report 10:40:05 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,900 10:40:05 INFO - PROCESS | 1652 | __end_cc_report 10:40:05 INFO - PROCESS | 1652 | __startTimestamp1486752005617__endTimestamp 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:40:05 INFO - PROCESS | 1652 | Number of tests: 14 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:136.90 Median:166.00 stddev:29.63 (17.8%) stddev-sans-first:29.24 10:40:05 INFO - PROCESS | 1652 | Values: 106.0 116.0 134.0 172.0 161.0 117.0 125.0 172.0 171.0 95.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:127.00 stddev:20.59 (16.2%) stddev-sans-first:21.37 10:40:05 INFO - PROCESS | 1652 | Values: 139.0 110.0 114.0 143.0 111.0 114.0 111.0 115.0 171.0 141.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:195.10 Median:195.50 stddev:2.08 (1.1%) stddev-sans-first:1.66 10:40:05 INFO - PROCESS | 1652 | Values: 199.0 193.0 196.0 197.0 194.0 193.0 195.0 193.0 197.0 194.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.90 Median:64.00 stddev:11.33 (17.7%) stddev-sans-first:10.81 10:40:05 INFO - PROCESS | 1652 | Values: 81.0 59.0 58.0 80.0 59.0 61.0 58.0 59.0 87.0 67.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:85.00 stddev:12.34 (14.5%) stddev-sans-first:12.85 10:40:05 INFO - PROCESS | 1652 | Values: 87.0 69.0 86.0 71.0 68.0 69.0 99.0 99.0 71.0 84.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:87.00 stddev:16.19 (18.6%) stddev-sans-first:17.12 10:40:05 INFO - PROCESS | 1652 | Values: 87.0 87.0 88.0 84.0 88.0 80.0 88.0 82.0 136.0 86.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:113.30 Median:93.50 stddev:23.96 (25.6%) stddev-sans-first:25.13 10:40:05 INFO - PROCESS | 1652 | Values: 103.0 96.0 148.0 150.0 139.0 93.0 121.0 94.0 94.0 95.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:88.00 stddev:18.41 (20.9%) stddev-sans-first:19.07 10:40:05 INFO - PROCESS | 1652 | Values: 87.0 88.0 105.0 121.0 140.0 86.0 89.0 88.0 89.0 89.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:59.00 stddev:1.97 (3.3%) stddev-sans-first:2.06 10:40:05 INFO - PROCESS | 1652 | Values: 57.0 55.0 56.0 56.0 59.0 57.0 59.0 60.0 59.0 61.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:2.56 (3.7%) stddev-sans-first:2.60 10:40:05 INFO - PROCESS | 1652 | Values: 67.0 73.0 68.0 73.0 66.0 66.0 69.0 69.0 69.0 71.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:85.00 stddev:9.21 (10.8%) stddev-sans-first:9.68 10:40:05 INFO - PROCESS | 1652 | Values: 87.0 101.0 77.0 93.0 102.0 105.0 84.0 88.0 86.0 84.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:157.00 stddev:21.94 (14.0%) stddev-sans-first:23.24 10:40:05 INFO - PROCESS | 1652 | Values: 159.0 130.0 149.0 155.0 160.0 137.0 137.0 151.0 204.0 179.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:167.00 stddev:18.42 (11.0%) stddev-sans-first:19.39 10:40:05 INFO - PROCESS | 1652 | Values: 166.0 165.0 166.0 169.0 168.0 164.0 174.0 224.0 166.0 162.0 10:40:05 INFO - PROCESS | 1652 | 10:40:05 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.48 10:40:05 INFO - PROCESS | 1652 | Values: 68.0 66.0 69.0 68.0 66.0 69.0 66.0 66.0 65.0 66.0 10:40:05 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:40:05 INFO - PROCESS | 1652 | 10:40:06 INFO - TEST-INFO | 1652: exit 0 10:40:06 INFO - TEST-OK | kraken | took 60218ms 10:40:06 INFO - SUITE-END | took 1174s 10:40:06 INFO - Completed test suite (00:19:34) 10:40:06 INFO - javascript benchmark 10:40:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7396.096033475046, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2764.834109953402, 3643.599204087551, 3647.617000214979, 3665.395209790385, 3680.4111342185247, 5972.19375384323, 6022.638641681497, 6104.816855494337, 6126.693665316739, 6155.261368635759, 6087.756489740416, 6174.629522228669, 6207.162033125526, 6208.6585237811905, 6229.221347331583, 5374.435684253156, 5443.074677304848, 5443.945560544384, 5451.836444906639, 5523.364813046491, 5510.090835012218, 5510.201020851974, 5529.557635389159, 5530.419305972875, 5565.2486914266665, 5349.277847490597, 5393.164059570773, 5479.6164268501225, 5481.0, 5497.202905578689, 5428.240046393508, 5454.372747134091, 5457.263269458652, 5463.918041229345, 5468.043092458804, 5301.787928482856, 5408.4591540845995, 5426.782928682848, 5447.400785913546, 5449.700266485342, 6108.129596501707, 6120.8738129976255, 6122.79460843403, 6139.890808645427, 6180.598261113013, 6268.373162683741, 6389.520785941027, 6424.357564243538, 6430.839229019265, 6450.419462248373, 6486.124373209604, 6489.5781774184525, 6528.21661400635, 6532.150820393366, 6551.082848401227, 6072.240969878765, 6110.862540392742, 6125.9693701531205, 6135.417135372132, 6208.286047104551, 6619.304972977864, 6658.134442522538, 6658.201015878126, 6666.200055993312, 6678.599284042973, 6306.936930630727, 6332.556721029576, 6335.11308416822, 6337.302896681362, 6338.714757835908, 6301.243850737941, 6347.0, 6401.07184458251, 6507.414332709984, 6510.251321098134, 5202.817901373433, 6359.109724638554, 6362.300146983828, 6378.521610879203, 6382.457491113215, 6369.140166077613, 6370.904436433365, 6372.107904893319, 6387.584806987624, 6399.488040956712, 4785.856424307276, 5151.6908985461, 5200.375954885362, 5227.059129356752, 5230.189320655304, 4600.378948841863, 4620.953790462119, 4653.441587009581, 4672.275797251432, 4697.812087516461, 6031.155638210654, 6245.469135123474, 6251.624902505773, 6262.5616206866, 6267.811965641038, 4858.344123543347, 6240.438360547572, 6487.351264873475, 6503.9349606504275, 6509.837254068686, 6093.0, 6147.323794382614, 6163.660998645118, 6193.256809182927, 6257.342978987232, 5732.369439361667, 5734.283214598176, 5735.139729040678, 5749.913751293734, 5753.338366087954, 5478.342598888159, 6520.673966301761, 6578.144841170617, 6580.638064906476, 6758.391744742997, 6315.4947604192475, 6445.355464453517, 6471.838204044937, 6493.577917435352, 6510.31641677636, 6703.966480167568, 6712.362325579063, 6714.294999025032, 6721.529492935448, 6745.156855393076, 6205.565610407228, 6252.968735156295, 6340.714667839866, 6398.296187419287, 6430.067640192239, 6373.171487706569, 6427.935720642734, 6453.225612926479, 6481.5786973848435, 6546.345365463416, 6331.841703957438, 6351.523635727246, 6374.936250637435, 6378.182218067828, 6446.4520515756685, 6122.081687746873, 6288.182536270256, 6338.461230795434, 6353.745850165941, 6355.396237357444, 5754.942450575608, 5899.144624029577, 6116.42707509198, 6134.467201660849, 6220.222472190976, 5220.7128607926925, 6272.686365681607, 6275.843103922439, 6288.559800814082, 6294.71673774672, 6049.848753781191, 6180.6600636965395, 6238.313785483684, 6243.344448832807, 6243.96878015607], "value": 5940.862225882252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.62805523912306, 518.9351331083615, 527.3776943207014, 528.801699362739, 577.780443431496, 33836.15409614758, 40108.59891401085, 41547.58452415475, 41638.375424368656, 41679.583204167946, 42801.78599107, 43814.34278485825, 43877.7806110969, 46120.538794612046, 46138.0, 9684.467354295512, 9840.753981150458, 9842.852357214648, 9870.407775533491, 9875.259355548327, 9699.175570076552, 9770.560324785401, 9791.971842956495, 9805.460699661517, 9807.31348805584, 8435.198656127657, 9778.706638800812, 9780.0, 9799.804003919917, 9813.0, 9697.224222062217, 9756.365836220622, 9769.755756106084, 9801.460919649417, 9837.852432213558, 8289.8342033159, 9811.166050885684, 9826.361286516425, 9834.508274586313, 9835.164011059069, 41501.1699766006, 41548.0, 41767.32930682769, 41808.0, 41896.37155442671, 3395.3442101074265, 3406.2506248625264, 3469.0633528947296, 3478.89563313101, 4125.690573207022, 29105.70894291051, 29855.701442985508, 29912.8504357479, 30161.396772064654, 30928.762849485993, 3347.364000839857, 3361.781484203519, 3418.4701371287492, 3484.9825750871337, 3485.721142308609, 494818.0, 494987.0, 499541.0, 502154.0, 504599.0, 63233.36766632367, 63254.683726581075, 63599.0, 63628.72742545123, 63871.6806415965, 57854.13218801721, 58482.707586461795, 66607.0, 66678.0, 72074.0, 14978.775318370233, 17214.397496087826, 17447.73828392575, 17615.0, 17806.198721057583, 13389.933050334686, 13523.729525409437, 13529.864701353057, 13549.119307245195, 13572.728545429036, 20255.696164557543, 20617.793822061587, 20734.963251837347, 20790.960451977342, 20888.0, 7449.553026818408, 7565.848683026308, 8261.03470334243, 8482.872756908651, 8586.613602387908, 866.8006358537446, 927.8051609162152, 1020.1889497849228, 1056.1497994114811, 1062.6068354708807, 31013.224669383446, 31150.0, 31604.367912641617, 31609.683903161134, 31625.36749265048, 921.3412410126791, 1017.2777328096986, 1054.9103326217205, 1110.6723516562633, 1124.1063354633086, 16027.0, 16134.193290335435, 16164.676706465805, 16211.0, 16243.756343654855, 563385.0, 571787.0, 572925.0, 575365.0, 575368.0, 59498.0, 59643.0, 59800.700996494736, 59868.70065649644, 59871.40128598658, 1201.4473342262481, 1366.863313668625, 1382.0740104130257, 1401.3833913078417, 1408.1199250468458, 29698.960536381124, 30345.601859901202, 30472.0, 30942.69057309398, 31045.844770776002, 51238.48761512337, 51331.74334128306, 51598.74200628973, 51608.74195628998, 51666.0, 562229.0, 564178.0, 568621.0, 569545.0, 571550.0, 28734.425311494073, 29460.0, 29475.852620736758, 29688.960886368874, 43362.69911902648, 47607.76196118997, 47666.28500572564, 47844.76077619589, 47951.76024119857, 48004.0, 32718.50922236121, 39435.2112957745, 39889.2022159561, 41029.38455923223, 41071.38392924049, 33686.15784605405, 39096.41355379728, 39321.80339098286, 39384.6061539381, 40362.59637403706, 29547.85226073942, 39084.41373379459, 39260.82217533478, 39450.60549394469, 39516.60483395129, 26543.0, 31981.36037279288, 34414.31171376609, 35513.0, 35637.0, 33108.33783324272, 33439.83280083584, 33533.82631607882, 34449.31101378008, 34462.48306275358], "value": 20592.074730808235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.6295232624928, 380.76392636565333, 390.4241244164857, 395.59451562148814, 410.0384598117416, 18980.715289270673, 19137.138828752704, 20417.795822041793, 20451.693224601626, 20630.793692063075, 17427.390041348557, 20308.883011434365, 20492.795072049274, 20632.793672063275, 20717.721050684413, 5292.782659988205, 5706.3722990470915, 5866.73599688015, 5875.823725288248, 5930.88138237235, 5848.181254624356, 5924.229850119478, 5933.762649494015, 5934.703264836762, 5947.613405128653, 5593.105103183491, 5844.444777746107, 5886.352501224862, 5890.646561206341, 5902.409759024106, 5673.574481913832, 5810.1865738796605, 5810.970945145268, 5836.328822185461, 5848.385919478436, 5008.323876276692, 5023.171176755831, 5091.745412729349, 5111.207762796773, 5117.82087626935, 24863.5027299453, 24934.50130997388, 25256.0, 25350.0, 25403.61894571583, 2284.348960546253, 2300.919467818635, 2425.34515680767, 2555.3228394475477, 2950.439416510856, 14698.191599462025, 15949.20253987296, 16061.759073613905, 16539.586510337216, 16591.751123733153, 1876.015092076657, 1927.5181204698824, 1947.7273181754565, 1963.6759934610773, 2028.2698228637678, 115573.0, 117594.41202793931, 118765.40617296945, 123260.76739232673, 123371.0, 11629.0, 11679.941600291944, 12018.939905300593, 12084.274943503418, 12119.757604847853, 14883.404663813542, 14918.209814822074, 14940.701185976219, 14944.0, 14979.400823967137, 8762.430442021248, 8862.335324850663, 8870.911290887008, 8883.866741998876, 8889.333300002525, 8815.074417186232, 8847.24798392131, 8898.510581917928, 8991.190792828676, 8991.640334386551, 3853.807309634507, 4646.0, 4653.86038418848, 4667.346571479996, 4672.2057250267535, 1839.7884243311923, 1989.3634037107986, 2010.6380851446588, 2018.6669199582198, 2051.507638166859, 854.3421565394611, 867.1415298854089, 924.2744445610164, 930.042056681619, 970.3062310448064, 17140.485785426456, 20960.895195523924, 21313.467163320733, 21771.45571360697, 22084.11663533473, 795.6697970342359, 908.7319240823973, 910.9205591374242, 972.3193764364972, 1006.4514839412537, 10803.513841877135, 11208.887911120948, 11214.719632009102, 11423.885761142283, 11437.0, 602198.0, 609024.0, 612033.0, 612820.0, 620472.0, 131036.34481827721, 133235.0, 134386.0, 137392.0, 141429.8785518218, 910.8497097978759, 1009.5709323537467, 1037.0510982451124, 1044.2011860926398, 1068.609957365556, 18299.908500457947, 18918.905405472884, 19553.60892782165, 19570.60858782788, 19597.804021959597, 43449.0, 53230.73384633052, 56079.0, 58038.83922321614, 58742.0, 80675.386492271, 82604.3479130426, 83345.16654833374, 84013.5799321024, 88273.55863220643, 8102.797430064295, 8121.187881211831, 8290.0, 8456.577171141294, 8542.316614670686, 9127.863082053642, 12606.432710527864, 13271.469141234242, 13275.86724132785, 13331.466741330238, 11115.610953616584, 11357.0, 11623.593174239199, 11640.417979101181, 11651.766964660828, 9397.295202859676, 11264.66206013821, 11299.943500282447, 11351.772964540498, 11401.885981140082, 11173.27373720738, 11351.432428378383, 11615.012723918562, 11803.822942655695, 11932.582359617372, 8121.025476942568, 8134.267915887362, 8185.672573097248, 8393.0, 8589.012263589768, 8254.54599997006, 10570.0, 11032.0, 11241.044511216638, 11294.0], "value": 9795.655252058788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.2155439948424, 1553.1069634959897, 1737.2008875917077, 1800.702884024136, 1855.7587513623218, 7712.884306735389, 7951.32413744831, 8259.463134896236, 8692.695755648554, 8709.825803483927, 8119.715809946653, 8435.957820210906, 8462.111478294783, 8537.445066070717, 8581.785455363619, 2361.49227915998, 2394.832361734679, 2395.281415575329, 2406.915757948472, 2412.3969007748065, 2365.7634236576378, 2395.113807891074, 2401.9639705404347, 2404.843685160468, 2422.1159276863905, 2339.0059224829465, 2352.7764862338136, 2354.117206047732, 2377.132346693453, 2395.6406539019113, 2084.6768750843644, 2350.30665953545, 2380.559596474649, 2391.7249516305674, 2400.8079353651665, 2393.712754469457, 2400.567897778399, 2402.8678422686744, 2422.321749910028, 2425.163318655061, 8523.914760852374, 8582.485050896967, 8603.139686031347, 8625.482471051757, 8664.826703465895, 5228.032813929397, 5389.9191512127345, 5391.81128660495, 5417.6207665463435, 5418.674879507203, 2918.781091418131, 3456.3432947740102, 3558.484019817138, 3583.87456439026, 3604.4232922732235, 1058.0953284941418, 1058.88352281249, 1081.4808891732014, 1099.19758576239, 1117.6870476266577, 11083.889161108447, 11148.442577871156, 11152.16358773087, 11178.329300242012, 11181.049610783093, 4565.908681826345, 4705.364775755298, 4781.0, 4785.306130611111, 4825.155597770447, 9656.565454554562, 9662.855057174149, 9663.082007209305, 9708.077732615391, 9737.977512361242, 5321.920171197435, 5324.707141107198, 5325.307709997753, 5339.81310654133, 5345.01117293302, 4008.3586626139677, 4359.651227901761, 4399.406080179199, 4865.416150062015, 4886.560209581155, 3733.197362567061, 3905.4727611772046, 3972.1261322509004, 3979.2837289287627, 4036.6770658347264, 1301.7982212757038, 1313.8292022037074, 1314.4019471140607, 1317.637649646355, 1322.1472150462898, 830.2610676497922, 860.7073594977612, 932.5523748600709, 936.9016253293306, 965.6089283840056, 5736.483716465538, 5840.561957853178, 5858.619189752652, 5941.287045554561, 6058.333583305921, 441.15738938627067, 457.2889157360337, 459.9264117741145, 463.28191303479474, 466.0515850244736, 3933.468981687493, 3948.0524674078015, 3972.7219094663674, 4012.137390461065, 4074.4499492568716, 9895.554700038516, 10038.548265328078, 10356.689299321033, 10405.635802746867, 10435.217358698128, 10052.69841904744, 10299.3820370778, 10326.86404495505, 10340.844887326695, 10347.482625868826, 7898.763037108896, 8015.679372825139, 8027.478213916077, 8078.959605202054, 8109.0, 5600.915986260128, 5647.830565083054, 5697.772089116389, 5740.1102829061565, 5909.70451477433, 9240.584173712334, 9410.106039926197, 9456.763580910532, 9504.95247523758, 9695.806083878424, 9320.533973301443, 9560.235181185628, 9560.330776845554, 9613.471259080818, 9737.853932191165, 5589.245451863946, 6949.965250173716, 7169.749058782918, 7412.481126321106, 7490.063742032246, 7986.800329991796, 8122.7563173102535, 8197.016358036835, 8202.958985205036, 8209.179082091743, 7190.245024272585, 7270.200277969525, 7308.780736577911, 7396.852062958818, 7459.850802983801, 7121.038659780863, 7122.537035092702, 7145.4998150128995, 7156.463265255231, 7175.067241258603, 6722.9663851680425, 6849.623270720158, 6855.760048398282, 6858.2455929848675, 6861.588304701734, 4880.487548807324, 4929.753512324298, 4951.430585482572, 5022.949770502249, 5051.974740126423, 5001.149804533311, 5001.474845141353, 5041.621878359065, 5072.746362681925, 5092.439831618445], "value": 4443.779962686496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4873294833464, 310.9642391125021, 323.17912502244303, 325.4012616785115, 326.6309070750052, 4769.856904292868, 5247.396549396821, 5361.651492652984, 5480.835574932748, 5508.980838544872, 3973.086190176261, 4388.824447022115, 4969.5030496950285, 5399.9730001349935, 5500.669959802414, 3182.6976437238427, 4116.464859568259, 4176.749395036292, 4234.1955028544635, 4248.638865696419, 3511.824408779564, 3845.788481633509, 3864.3237433449035, 4006.0325196755957, 4175.603317684815, 3367.2423704666376, 4043.07009387841, 4054.209429161315, 4078.7159190853067, 4092.89767755807, 3728.527231743446, 3874.8256328465286, 4056.675465962716, 4066.3087275163293, 4080.8163632636456, 3576.6065732769375, 3584.4623306503972, 3585.0858031202138, 3596.8021758803256, 3599.4780756790383, 4340.978295108536, 4975.975120124413, 5281.683099014072, 5327.0, 5399.488143319877, 4709.411323584552, 4720.858374248778, 4727.338172655831, 4732.621390288768, 4733.5976442002475, 4991.950080499221, 5704.377720147694, 5760.82717518471, 5784.409287445944, 5809.390014048507, 3298.526105420934, 3475.8088305143206, 3675.9264814703556, 3691.280200360931, 3932.233214523169, 5210.557102646279, 5964.552658550582, 6066.696665166768, 6100.23747031621, 6124.234470691164, 3997.620226078518, 4008.579099194601, 4022.0, 4023.0, 4050.8379664813665, 3714.257148570297, 3783.5270591176104, 4065.166640838621, 4087.4073259377224, 4115.238680843993, 4684.81260749573, 4704.388429504143, 4710.599599034121, 4731.905361892743, 4786.664933454695, 5064.987002599495, 5845.655499235115, 5876.353601103875, 5895.263092113486, 5915.49154965481, 1288.7035981724257, 1319.7426501832051, 1320.3662242123835, 1338.377654390713, 1343.8320209973754, 782.7299581644323, 815.176671561727, 888.4003297773977, 894.874717539545, 907.2968449451728, 4994.126027945168, 5243.68537887728, 5259.63182577216, 5268.631195816332, 5314.671332166959, 5138.409082955433, 5726.541876649858, 5730.971345143247, 5757.337906140848, 5785.450382213683, 4692.451491008027, 4804.471508134103, 4947.330578797233, 5217.217417387422, 5226.869328266747, 2573.84556926585, 2938.4563855686765, 3002.2944608017096, 3008.4283986042583, 3014.457397668397, 5371.677699338053, 5625.943740562542, 5669.8943705976935, 5719.710217336998, 5992.520598352121, 5470.56235501159, 5669.716514174274, 5811.651300921958, 5816.331121920949, 5916.8462149881225, 5689.601727879009, 5965.55258355625, 5965.582409231399, 5968.8806223876145, 5975.028240680565, 5598.356189038313, 5728.598998070095, 5730.194988578584, 5737.762272713561, 5744.569157313134, 5664.320281566238, 6006.48944839676, 6043.12374705674, 6052.878942421215, 6086.69566521681, 5088.54203121706, 6328.392816094782, 6349.238091428873, 6377.2984971654005, 6393.073004414427, 3872.76763394186, 3951.42704307868, 3965.524137103566, 3986.8405263789123, 3990.620891015465, 5152.871178220575, 5751.447109280387, 5780.21967034445, 6047.516198704181, 6053.303870054824, 4697.060587882505, 4959.479254678351, 5476.589255805751, 5779.092899343291, 5823.82528524145, 5931.169636250842, 5931.881362372642, 5940.316863560746, 5945.929732648165, 5963.4334738199805, 4611.423572053493, 5668.858278543069, 5805.477507024388, 5848.502877255481, 5883.823485295448, 5450.427705091067, 5910.822675319575, 5921.437463440966, 5925.555583331181, 6016.398360163948, 5488.670679759227, 5791.623544469596, 5829.504492118217, 5912.940870591411, 5927.318358388668], "value": 4178.064906816882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.4254298760079, 744.2297222374843, 761.4859969520572, 794.1145622630764, 817.5340056167983, 12990.610281691552, 14603.634909127277, 14919.254037298133, 15420.61448463789, 15545.222738863069, 11938.880611193885, 14030.719385612281, 14095.083819551748, 14169.71660566788, 14215.71568568628, 828.9336853051757, 861.0528418739368, 862.560094351882, 862.7282406042077, 864.2222000199807, 824.2087595907906, 859.7721603775004, 862.6980556805099, 864.9481031138121, 866.5493943149559, 901.9323550733689, 914.085914085914, 914.7804526913526, 915.2906497464452, 916.1754421021101, 893.2452077994085, 897.2911399993997, 907.5054095517926, 907.5144797533288, 911.9817603647956, 661.7452280871898, 677.4715721737053, 677.986410316575, 681.8840797064511, 682.0553533356288, 14563.490277840225, 14854.331555080047, 14871.47949821751, 14937.626559335995, 15288.082715037022, 13606.455741770318, 13648.454061837514, 13947.45570566486, 13984.230867302294, 14007.929960350235, 11472.94263528677, 11613.669362685161, 11799.351035693033, 11905.0, 11981.400929953556, 3727.310447567209, 3757.8684746034032, 3769.2838360711376, 3770.057485628593, 3782.470454136423, 74730.0, 95206.0479395211, 95795.56306655335, 102049.48975255151, 102862.42843928962, 9290.581923813445, 10383.037003587757, 10661.733456663645, 10662.147028237878, 10704.732381690521, 19462.610747784965, 20205.49486262855, 20236.89881550583, 20965.895170524356, 21086.683699744517, 7969.0, 7970.561619111005, 8148.348132149414, 8175.877361839577, 8286.839842422065, 3816.5420149581673, 4399.36209249657, 4479.0, 4524.02733412318, 4605.148047611203, 3400.302937897725, 3471.114865709228, 3477.2523907360037, 3514.683678468899, 3515.648435156515, 636.8312397214742, 641.8097450093911, 645.8482256669679, 661.8146918862726, 665.3180489997694, 606.6572386601556, 635.291649810458, 638.581728967527, 645.7191121861911, 683.6069260175319, 8731.432456890281, 9241.306901982378, 9338.579763910504, 9428.717138485856, 9677.161339345503, 553.6788662575697, 613.3375953969702, 652.9846089331136, 663.2339647706906, 698.1447726534954, 4259.893502662459, 4297.8495752648505, 4571.22289210835, 4626.444826620827, 4627.421572303462, 82146.58926705328, 102831.0, 103207.0, 107859.92140078655, 112465.0, 90903.0, 93393.53303233441, 96054.0, 96769.0, 97402.5129874346, 83932.0, 87822.80442988849, 88907.55546222356, 89723.55138224267, 89759.55120224357, 6941.687624056828, 8729.127087291221, 8913.0, 9044.14080662336, 9351.53242337894, 58889.0, 59317.0, 59368.109478358725, 59565.0, 60572.78854422799, 81807.59096204481, 83291.0, 83891.0, 84018.15981840104, 84700.30599387854, 11398.953470527322, 11501.0, 11671.241369310968, 11731.530738770694, 11859.34773587461, 12628.684282892633, 12742.299173545172, 12849.03632227568, 13118.409671564994, 13149.145305555108, 11813.704657383634, 11890.643280701594, 12009.699757506132, 12050.758984820079, 12187.51249949992, 11082.390468524309, 11864.466099025738, 11926.0, 11964.0, 12008.63974080779, 11771.52913883435, 11912.808719128017, 11923.84018235151, 12000.459979300778, 12084.637460876187, 10321.845172322572, 10620.309679870783, 10636.149108071491, 10673.41296228715, 10818.29681070728, 10431.0, 10443.0, 10602.045815876609, 10624.575016999233, 10640.89359106399], "value": 7356.267741893056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 134.0, 172.0, 161.0, 117.0, 125.0, 172.0, 171.0, 95.0], "value": 136.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 114.0, 143.0, 111.0, 114.0, 111.0, 115.0, 171.0, 141.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 193.0, 196.0, 197.0, 194.0, 193.0, 195.0, 193.0, 197.0, 194.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 80.0, 59.0, 61.0, 58.0, 59.0, 87.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 86.0, 71.0, 68.0, 69.0, 99.0, 99.0, 71.0, 84.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 84.0, 88.0, 80.0, 88.0, 82.0, 136.0, 86.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 148.0, 150.0, 139.0, 93.0, 121.0, 94.0, 94.0, 95.0], "value": 113.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 105.0, 121.0, 140.0, 86.0, 89.0, 88.0, 89.0, 89.0], "value": 98.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 59.0, 57.0, 59.0, 60.0, 59.0, 61.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 68.0, 73.0, 66.0, 66.0, 69.0, 69.0, 69.0, 71.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 101.0, 77.0, 93.0, 102.0, 105.0, 84.0, 88.0, 86.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 149.0, 155.0, 160.0, 137.0, 137.0, 151.0, 204.0, 179.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 169.0, 168.0, 164.0, 174.0, 224.0, 166.0, 162.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 68.0, 66.0, 69.0, 66.0, 66.0, 65.0, 66.0], "value": 66.9, "unit": "score"}]}]} 10:40:06 INFO - Return code: 0 10:40:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:06 ERROR - # TBPL SUCCESS # 10:40:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:40:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:40:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:40:06 INFO - 2017-02-10 10:40:06.948 screenresolution[1657:10459] starting screenresolution argv=screenresolution get 10:40:06 INFO - 2017-02-10 10:40:06.951 screenresolution[1657:10459] Display 0: 1600x1200x32@60 10:40:06 INFO - 2017-02-10 10:40:06.957 screenresolution[1658:10462] starting screenresolution argv=screenresolution list 10:40:06 INFO - Available Modes on Display 0 10:40:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:40:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:40:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:40:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:40:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:40:07 INFO - Intel Iris: 10:40:07 INFO - Chipset Model: Intel Iris 10:40:07 INFO - Type: GPU 10:40:07 INFO - Bus: Built-In 10:40:07 INFO - VRAM (Dynamic, Max): 1536 MB 10:40:07 INFO - Vendor: Intel (0x8086) 10:40:07 INFO - Device ID: 0x0a2e 10:40:07 INFO - Revision ID: 0x0009 10:40:07 INFO - Displays: 10:40:07 INFO - Display: 10:40:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:40:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:40:07 INFO - Display Serial Number: 1600x1200 60 10:40:07 INFO - Main Display: Yes 10:40:07 INFO - Mirror: Off 10:40:07 INFO - Online: Yes 10:40:07 INFO - Rotation: Supported 10:40:07 INFO - Return code: 0 10:40:07 INFO - Running post-action listener: _resource_record_post_action 10:40:07 INFO - [mozharness: 2017-02-10 18:40:07.195758Z] Finished run-tests step (success) 10:40:07 INFO - Running post-run listener: _resource_record_post_run 10:40:07 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 38184960; Write bytes: 504044032; Read time: 245; Write time: 1605 10:40:07 INFO - TinderboxPrint: CPU usage
54.3% 10:40:07 INFO - TinderboxPrint: I/O read bytes / time
38,184,960 / 245 10:40:07 INFO - TinderboxPrint: I/O write bytes / time
504,044,032 / 1,605 10:40:07 INFO - TinderboxPrint: CPU idle
2,187.5 (45.7%) 10:40:07 INFO - TinderboxPrint: CPU system
967.8 (20.2%) 10:40:07 INFO - TinderboxPrint: CPU user
1,630.4 (34.1%) 10:40:07 INFO - TinderboxPrint: Swap in / out
229,699,584 / 0 10:40:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187077120; Write bytes: 188897280; Read time: 16849; Write time: 393 10:40:07 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36190208; Write bytes: 308244992; Read time: 228; Write time: 1185 10:40:07 INFO - Running post-run listener: _upload_blobber_files 10:40:07 INFO - Blob upload gear active. 10:40:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:40:07 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:40:07 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:40:08 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:09 INFO - (blobuploader) - INFO - Done attempting. 10:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:10 INFO - (blobuploader) - INFO - Done attempting. 10:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:12 INFO - (blobuploader) - INFO - Done attempting. 10:40:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:12 INFO - Return code: 0 10:40:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:40:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/320375105fe808770b284025c55363042f9a93eb04e2c69d447a9be34de73689fcdfa71558c54173bf9a9800352dc9d4ebe1f0d0c639b80f033f10c38eaa6a8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34ab9a85a40a37eb143a28df3900beef65d8e0d3a9e6517d17f6ebcb418fea9a06381dd2bf2f5db08b424f88986f923857d2af13e8bf09a7f668fbf27b928aa3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03d7b0e4d06c7f792ef5e210b8a6711b667d5ff249614cfabc69d48bb13b5036a8c12e6319af1accc164726b0b6eaebcc3b51d2c6c67662805e18c26bcd71e89"} 10:40:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:12 INFO - Contents: 10:40:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/320375105fe808770b284025c55363042f9a93eb04e2c69d447a9be34de73689fcdfa71558c54173bf9a9800352dc9d4ebe1f0d0c639b80f033f10c38eaa6a8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34ab9a85a40a37eb143a28df3900beef65d8e0d3a9e6517d17f6ebcb418fea9a06381dd2bf2f5db08b424f88986f923857d2af13e8bf09a7f668fbf27b928aa3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03d7b0e4d06c7f792ef5e210b8a6711b667d5ff249614cfabc69d48bb13b5036a8c12e6319af1accc164726b0b6eaebcc3b51d2c6c67662805e18c26bcd71e89"} 10:40:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:12 INFO - Copying logs to upload dir... 10:40:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.383758 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-10 10:40:12.461919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:40:12.467143) ========= 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.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/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-Beta/sha512/320375105fe808770b284025c55363042f9a93eb04e2c69d447a9be34de73689fcdfa71558c54173bf9a9800352dc9d4ebe1f0d0c639b80f033f10c38eaa6a8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34ab9a85a40a37eb143a28df3900beef65d8e0d3a9e6517d17f6ebcb418fea9a06381dd2bf2f5db08b424f88986f923857d2af13e8bf09a7f668fbf27b928aa3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03d7b0e4d06c7f792ef5e210b8a6711b667d5ff249614cfabc69d48bb13b5036a8c12e6319af1accc164726b0b6eaebcc3b51d2c6c67662805e18c26bcd71e89"} build_url:https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/MdBdolUESFi6GQ7qY0cvWg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/320375105fe808770b284025c55363042f9a93eb04e2c69d447a9be34de73689fcdfa71558c54173bf9a9800352dc9d4ebe1f0d0c639b80f033f10c38eaa6a8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34ab9a85a40a37eb143a28df3900beef65d8e0d3a9e6517d17f6ebcb418fea9a06381dd2bf2f5db08b424f88986f923857d2af13e8bf09a7f668fbf27b928aa3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03d7b0e4d06c7f792ef5e210b8a6711b667d5ff249614cfabc69d48bb13b5036a8c12e6319af1accc164726b0b6eaebcc3b51d2c6c67662805e18c26bcd71e89"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 10:40:12.500866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:40:12.501235) ========= 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.obxiTX5Usg/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.vB3pRqYb5k/Listeners TMPDIR=/var/folders/r0/nfy68rhs4pz8qyrz7_3847cc00000w/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.004976 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 10:40:12.549503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:40:12.549832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 10:40:12.550120) ========= ========= Total master_lag: 0.18 =========