builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0372 starttime: 1479839040.47 results: success (0) buildid: 20161122080251 builduid: d817ad58cc1c4735b4649929257b8e0a revision: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.473076) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.473589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.473864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.501615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.501996) ========= 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.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-22 10:24: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% 153M=0s 2016-11-22 10:24:00 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.609135) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.609457) ========= 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.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.024265 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:00.658120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-22 10:24:00.658473) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ba0440fe03102f644bbe3f5c00923caa935d5e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ba0440fe03102f644bbe3f5c00923caa935d5e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-22 10:24:00,759 truncating revision to first 12 chars 2016-11-22 10:24:00,759 Setting DEBUG logging. 2016-11-22 10:24:00,759 attempt 1/10 2016-11-22 10:24:00,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ba0440fe031?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 10:24:02,985 unpacking tar archive at: mozilla-aurora-7ba0440fe031/testing/mozharness/ program finished with exit code 0 elapsedTime=2.495691 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-22 10:24:03.182012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:03.182480) ========= script_repo_revision: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:03.182917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:03.183240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 10:24:03.203498) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-22 10:24:03.203805) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:03 INFO - MultiFileLogger online at 20161122 10:24:03 in /builds/slave/test 10:24:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:24:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:24:03 INFO - {'append_to_log': False, 10:24:03 INFO - 'base_work_dir': '/builds/slave/test', 10:24:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:24:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:24:03 INFO - 'branch': 'Mozilla-Aurora', 10:24:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:24:03 INFO - 'config_files': ('talos/mac_config.py',), 10:24:03 INFO - 'default_actions': ('clobber', 10:24:03 INFO - 'read-buildbot-config', 10:24:03 INFO - 'download-and-extract', 10:24:03 INFO - 'populate-webroot', 10:24:03 INFO - 'create-virtualenv', 10:24:03 INFO - 'install', 10:24:03 INFO - 'run-tests'), 10:24:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:24:03 INFO - 'download_minidump_stackwalk': True, 10:24:03 INFO - 'download_symbols': 'ondemand', 10:24:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:24:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:24:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:24:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:24:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:24:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:24:03 INFO - 'installer_path': 'installer.exe', 10:24:03 INFO - 'log_level': 'info', 10:24:03 INFO - 'log_name': 'talos', 10:24:03 INFO - 'log_to_console': True, 10:24:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:24:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:24:03 INFO - 'opt_config_files': (), 10:24:03 INFO - 'pip_index': False, 10:24:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:24:03 INFO - 'cmd': ('bash', 10:24:03 INFO - '-c', 10:24:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:24:03 INFO - 'enabled': True, 10:24:03 INFO - 'halt_on_failure': False, 10:24:03 INFO - 'name': 'check_screen_resolution'},), 10:24:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:24:03 INFO - 'cmd': ('bash', 10:24:03 INFO - '-c', 10:24:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:24:03 INFO - 'enabled': True, 10:24:03 INFO - 'halt_on_failure': False, 10:24:03 INFO - 'name': 'check_screen_resolution'},), 10:24:03 INFO - 'run_cmd_checks_enabled': True, 10:24:03 INFO - 'sps_profile': False, 10:24:03 INFO - 'sps_profile_interval': 0, 10:24:03 INFO - 'suite': 'dromaeojs', 10:24:03 INFO - 'system_bits': '32', 10:24:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:24:03 INFO - 'title': 't-yosemite-r7-0372', 10:24:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:24:03 INFO - 'use_talos_json': True, 10:24:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:24:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:24:03 INFO - 'work_dir': 'build'} 10:24:03 INFO - [mozharness: 2016-11-22 18:24:03.411334Z] Running clobber step. 10:24:03 INFO - Running pre-action listener: _resource_record_pre_action 10:24:03 INFO - Running main action method: clobber 10:24:03 INFO - rmtree: /builds/slave/test/build 10:24:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:24:05 INFO - Running post-action listener: _resource_record_post_action 10:24:05 INFO - [mozharness: 2016-11-22 18:24:05.691600Z] Finished clobber step (success) 10:24:05 INFO - [mozharness: 2016-11-22 18:24:05.691722Z] Running read-buildbot-config step. 10:24:05 INFO - Running pre-action listener: _resource_record_pre_action 10:24:05 INFO - Running main action method: read_buildbot_config 10:24:05 INFO - Using buildbot properties: 10:24:05 INFO - { 10:24:05 INFO - "project": "", 10:24:05 INFO - "product": "firefox", 10:24:05 INFO - "script_repo_revision": "production", 10:24:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 10:24:05 INFO - "repository": "", 10:24:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 10:24:05 INFO - "buildid": "20161122080251", 10:24:05 INFO - "pgo_build": "False", 10:24:05 INFO - "basedir": "/builds/slave/test", 10:24:05 INFO - "buildnumber": 29, 10:24:05 INFO - "slavename": "t-yosemite-r7-0372", 10:24:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:24:05 INFO - "platform": "yosemite_r7", 10:24:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:24:05 INFO - "branch": "mozilla-aurora", 10:24:05 INFO - "repo_path": "releases/mozilla-aurora", 10:24:05 INFO - "revision": "7ba0440fe03102f644bbe3f5c00923caa935d5e5", 10:24:05 INFO - "stage_platform": "macosx64", 10:24:05 INFO - "builduid": "d817ad58cc1c4735b4649929257b8e0a", 10:24:05 INFO - "slavebuilddir": "test" 10:24:05 INFO - } 10:24:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:24:05 INFO - Running post-action listener: _resource_record_post_action 10:24:05 INFO - [mozharness: 2016-11-22 18:24:05.695035Z] Finished read-buildbot-config step (success) 10:24:05 INFO - [mozharness: 2016-11-22 18:24:05.695171Z] Running download-and-extract step. 10:24:05 INFO - Running pre-action listener: _resource_record_pre_action 10:24:05 INFO - Running main action method: download_and_extract 10:24:05 INFO - mkdir: /builds/slave/test/build/tests 10:24: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:24:05 INFO - trying https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:24:07 INFO - Downloaded 1199 bytes. 10:24:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:24:07 INFO - Using the following test package requirements: 10:24:07 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:24:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:24:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:24:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'jsshell-mac.zip'], 10:24:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:24:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:24:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:24:07 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:24:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:24:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:24:07 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:24:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:24:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:24:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:24:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:24:08 INFO - Http code: 200 10:24:08 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 10:24:08 INFO - x-amz-cf-id: qBaiuGphLHQU2KcEyBQ68qzWoQ-2k6oHpo_aDAL5LtLUzoiHsR7-oA== 10:24:08 INFO - x-amz-version-id: 5VIi.hnYWmNGeV86P_kh8vBLfNZttLGC 10:24:09 INFO - Expected file size: 16277173 10:24:09 INFO - Obtained file size: 16277173 10:24:15 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:24:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:24:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:24:15 INFO - Fetch https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:24:16 INFO - Http code: 200 10:24:16 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 10:24:16 INFO - x-amz-cf-id: d5KzdHLqxafIdBSUObaOOj4ISUktmSsnU11meqV3JnoYoaeCH0e0kA== 10:24:16 INFO - x-amz-version-id: 5VIi.hnYWmNGeV86P_kh8vBLfNZttLGC 10:24:16 INFO - Expected file size: 16277173 10:24:16 INFO - Obtained file size: 16277173 10:24:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:24:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:24:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:24:24 INFO - Http code: 200 10:24:24 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 10:24:24 INFO - x-amz-cf-id: 4vGZhJ9rBdC1o0M0bdtFovEeSPsI1r8BVdsJc0SD1TZDz2Dh7QYf3Q== 10:24:24 INFO - x-amz-version-id: JNLnjf.tlMjfx1rPgYOCAqOMCTm4KImX 10:24:24 INFO - Expected file size: 14409038 10:24:24 INFO - Obtained file size: 14409038 10:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:25 INFO - trying https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:24:25 INFO - Downloading https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:24:30 INFO - Downloaded 114506509 bytes. 10:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:24:30 INFO - mkdir: /builds/slave/test/properties 10:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 10:24:30 INFO - Contents: 10:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:24:31 INFO - Running post-action listener: _resource_record_post_action 10:24:31 INFO - Running post-action listener: set_extra_try_arguments 10:24:31 INFO - [mozharness: 2016-11-22 18:24:31.366850Z] Finished download-and-extract step (success) 10:24:31 INFO - [mozharness: 2016-11-22 18:24:31.366999Z] Running populate-webroot step. 10:24:31 INFO - Running pre-action listener: _resource_record_pre_action 10:24:31 INFO - Running main action method: populate_webroot 10:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:24:31 INFO - '--tppagecycles', 10:24:31 INFO - '7'], 10:24:31 INFO - 'tests': ['tsvgm']}}, 10:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:24:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['damp', 'tps']}, 10:24:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'tests': ['damp', 'tps']}, 10:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['dromaeo_dom']}, 10:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:24:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['basic_compositor_video']}, 10:24:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['a11yr', 10:24:31 INFO - 'ts_paint', 10:24:31 INFO - 'tpaint', 10:24:31 INFO - 'sessionrestore', 10:24:31 INFO - 'sessionrestore_no_auto_restore', 10:24:31 INFO - 'tabpaint']}, 10:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['tsvgx', 10:24:31 INFO - 'tsvgr_opacity', 10:24:31 INFO - 'tart', 10:24:31 INFO - 'tscrollx', 10:24:31 INFO - 'cart']}, 10:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:24:31 INFO - 'tsvgr_opacity', 10:24:31 INFO - 'tart', 10:24:31 INFO - 'tscrollx', 10:24:31 INFO - 'cart']}, 10:24:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'talos_options': ['--disable-e10s'], 10:24:31 INFO - 'tests': ['tp5o']}, 10:24:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'tests': ['tp5o']}, 10:24:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'talos_options': ['--disable-e10s', 10:24:31 INFO - '--xperf_path', 10:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:31 INFO - 'tests': ['tp5n']}, 10:24:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:31 INFO - 'talos_options': ['--xperf_path', 10:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:31 INFO - 'tests': ['tp5n']}}, 10:24:31 INFO - 'talos.zip': {'path': '', 10:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:24:31 INFO - Running post-action listener: _resource_record_post_action 10:24:31 INFO - [mozharness: 2016-11-22 18:24:31.386162Z] Finished populate-webroot step (success) 10:24:31 INFO - [mozharness: 2016-11-22 18:24:31.386301Z] Running create-virtualenv step. 10:24:31 INFO - Running pre-action listener: _resource_record_pre_action 10:24:31 INFO - Running main action method: create_virtualenv 10:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:24:31 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:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:24:31 INFO - Using real prefix '/tools/python27' 10:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:24:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:24:35 INFO - Installing pip.................done. 10:24:35 INFO - Return code: 0 10:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:24:35 INFO - Reading from file tmpfile_stdout 10:24:35 INFO - Output received: 10:24:35 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:24:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:35 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:35 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:24:35 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:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:35 INFO - 'HOME': '/Users/cltbld', 10:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:35 INFO - 'LOGNAME': 'cltbld', 10:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:35 INFO - 'MOZ_NO_REMOTE': '1', 10:24:35 INFO - 'NO_EM_RESTART': '1', 10:24:35 INFO - 'PAGER': '/bin/cat', 10:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:35 INFO - 'PWD': '/builds/slave/test', 10:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:35 INFO - 'SHELL': '/bin/bash', 10:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:35 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:35 INFO - 'USER': 'cltbld', 10:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:35 INFO - 'XPC_FLAGS': '0x0', 10:24:35 INFO - 'XPC_SERVICE_NAME': '0', 10:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:35 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:24:35 INFO - Cleaning up... 10:24:35 INFO - Return code: 0 10:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:35 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:35 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:24:35 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:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:35 INFO - 'HOME': '/Users/cltbld', 10:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:35 INFO - 'LOGNAME': 'cltbld', 10:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:35 INFO - 'MOZ_NO_REMOTE': '1', 10:24:35 INFO - 'NO_EM_RESTART': '1', 10:24:35 INFO - 'PAGER': '/bin/cat', 10:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:35 INFO - 'PWD': '/builds/slave/test', 10:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:35 INFO - 'SHELL': '/bin/bash', 10:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:35 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:35 INFO - 'USER': 'cltbld', 10:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:35 INFO - 'XPC_FLAGS': '0x0', 10:24:35 INFO - 'XPC_SERVICE_NAME': '0', 10:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:35 INFO - Downloading/unpacking psutil>=3.1.1 10:24:35 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:24:35 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:24:35 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:24:35 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:24:35 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:24:35 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:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:39 INFO - Installing collected packages: psutil 10:24:39 INFO - Running setup.py install for psutil 10:24:39 INFO - building 'psutil._psutil_osx' extension 10:24:39 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:24:39 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:24:39 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:24:40 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:24:40 INFO - building 'psutil._psutil_posix' extension 10:24:40 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:24:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:24:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:24:40 INFO - ^ 10:24:40 INFO - 1 warning generated. 10:24:40 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:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:40 INFO - Successfully installed psutil 10:24:40 INFO - Cleaning up... 10:24:40 INFO - Return code: 0 10:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:24: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:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:24: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 mozsystemmonitor==0.3 10:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:40 INFO - 'HOME': '/Users/cltbld', 10:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:40 INFO - 'LOGNAME': 'cltbld', 10:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:40 INFO - 'MOZ_NO_REMOTE': '1', 10:24:40 INFO - 'NO_EM_RESTART': '1', 10:24:40 INFO - 'PAGER': '/bin/cat', 10:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:40 INFO - 'PWD': '/builds/slave/test', 10:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:40 INFO - 'SHELL': '/bin/bash', 10:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:40 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:40 INFO - 'USER': 'cltbld', 10:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:40 INFO - 'XPC_FLAGS': '0x0', 10:24:40 INFO - 'XPC_SERVICE_NAME': '0', 10:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:24:40 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:24:40 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:24:40 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:24:40 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:24:40 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:24:40 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:24:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:24:43 INFO - Installing collected packages: mozsystemmonitor 10:24:43 INFO - Running setup.py install for mozsystemmonitor 10:24:43 INFO - Successfully installed mozsystemmonitor 10:24:43 INFO - Cleaning up... 10:24:43 INFO - Return code: 0 10:24:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:24:43 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:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:43 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:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:43 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:43 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:24:43 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:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:43 INFO - 'HOME': '/Users/cltbld', 10:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:43 INFO - 'LOGNAME': 'cltbld', 10:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:43 INFO - 'MOZ_NO_REMOTE': '1', 10:24:43 INFO - 'NO_EM_RESTART': '1', 10:24:43 INFO - 'PAGER': '/bin/cat', 10:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:43 INFO - 'PWD': '/builds/slave/test', 10:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:43 INFO - 'SHELL': '/bin/bash', 10:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:43 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:43 INFO - 'USER': 'cltbld', 10:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:43 INFO - 'XPC_FLAGS': '0x0', 10:24:43 INFO - 'XPC_SERVICE_NAME': '0', 10:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:24:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:24: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:24: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:24: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:24: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:24: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:24: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:24:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:24:46 INFO - warning: no files found matching '*.txt' 10:24:46 INFO - no previously-included directories found matching 'build' 10:24:46 INFO - no previously-included directories found matching 'dist' 10:24:46 INFO - no previously-included directories found matching '.git*' 10:24:46 INFO - Installing collected packages: jsonschema, functools32 10:24:46 INFO - Running setup.py install for functools32 10:24:46 INFO - warning: no files found matching '*.txt' 10:24:46 INFO - no previously-included directories found matching 'build' 10:24:46 INFO - no previously-included directories found matching 'dist' 10:24:46 INFO - no previously-included directories found matching '.git*' 10:24:47 INFO - Successfully installed jsonschema functools32 10:24:47 INFO - Cleaning up... 10:24:47 INFO - Return code: 0 10:24:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:24:47 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:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:47 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:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:47 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:47 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:24:47 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:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:47 INFO - 'HOME': '/Users/cltbld', 10:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:47 INFO - 'LOGNAME': 'cltbld', 10:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:47 INFO - 'MOZ_NO_REMOTE': '1', 10:24:47 INFO - 'NO_EM_RESTART': '1', 10:24:47 INFO - 'PAGER': '/bin/cat', 10:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:47 INFO - 'PWD': '/builds/slave/test', 10:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:47 INFO - 'SHELL': '/bin/bash', 10:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:47 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:47 INFO - 'USER': 'cltbld', 10:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:47 INFO - 'XPC_FLAGS': '0x0', 10:24:47 INFO - 'XPC_SERVICE_NAME': '0', 10:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:24:47 INFO - Cleaning up... 10:24:47 INFO - Return code: 0 10:24:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:24:47 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:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:47 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:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:47 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:47 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:24:47 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:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:47 INFO - 'HOME': '/Users/cltbld', 10:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:47 INFO - 'LOGNAME': 'cltbld', 10:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:47 INFO - 'MOZ_NO_REMOTE': '1', 10:24:47 INFO - 'NO_EM_RESTART': '1', 10:24:47 INFO - 'PAGER': '/bin/cat', 10:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:47 INFO - 'PWD': '/builds/slave/test', 10:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:47 INFO - 'SHELL': '/bin/bash', 10:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:47 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:47 INFO - 'USER': 'cltbld', 10:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:47 INFO - 'XPC_FLAGS': '0x0', 10:24:47 INFO - 'XPC_SERVICE_NAME': '0', 10:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:24: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:24: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:24: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:24: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:24: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:24: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:24:51 INFO - Downloading docopt-0.6.1.tar.gz 10:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:24:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:24:51 INFO - Running setup.py install for blobuploader 10:24:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:24:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:24:51 INFO - Running setup.py install for requests 10:24:52 INFO - Running setup.py install for docopt 10:24:52 INFO - Successfully installed blobuploader requests docopt 10:24:52 INFO - Cleaning up... 10:24:52 INFO - Return code: 0 10:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24: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:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:53 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:53 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:24:53 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:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:53 INFO - 'HOME': '/Users/cltbld', 10:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:53 INFO - 'LOGNAME': 'cltbld', 10:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:53 INFO - 'MOZ_NO_REMOTE': '1', 10:24:53 INFO - 'NO_EM_RESTART': '1', 10:24:53 INFO - 'PAGER': '/bin/cat', 10:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:53 INFO - 'PWD': '/builds/slave/test', 10:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:53 INFO - 'SHELL': '/bin/bash', 10:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:53 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:53 INFO - 'USER': 'cltbld', 10:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:53 INFO - 'XPC_FLAGS': '0x0', 10:24:53 INFO - 'XPC_SERVICE_NAME': '0', 10:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:53 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-NjRLL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:53 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-z0q4oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:53 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-P8JO4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:53 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-mRcPHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:53 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-3GDl4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-fNdKSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-4Ey0rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-7VR4MM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-FWaKDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-1_kzNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-vrZTC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-LeMeug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-VCylsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-i2fndi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:54 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ELzSZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:24:55 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-I574B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:24:55 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-TCnxIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:24:55 INFO - Running setup.py install for manifestparser 10:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:24:55 INFO - Running setup.py install for mozcrash 10:24:55 INFO - Running setup.py install for mozdebug 10:24:55 INFO - Running setup.py install for mozdevice 10:24:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:24:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:24:55 INFO - Running setup.py install for mozfile 10:24:56 INFO - Running setup.py install for mozhttpd 10:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Running setup.py install for mozinfo 10:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Running setup.py install for mozInstall 10:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Running setup.py install for mozleak 10:24:56 INFO - Running setup.py install for mozlog 10:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Running setup.py install for moznetwork 10:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:24:56 INFO - Running setup.py install for mozprocess 10:24:57 INFO - Running setup.py install for mozprofile 10:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:24:57 INFO - Running setup.py install for mozrunner 10:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:24:57 INFO - Running setup.py install for mozscreenshot 10:24:57 INFO - Running setup.py install for moztest 10:24:57 INFO - Running setup.py install for mozversion 10:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:24:57 INFO - Cleaning up... 10:24:57 INFO - Return code: 0 10:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:58 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:24:58 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:24:58 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:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:58 INFO - 'HOME': '/Users/cltbld', 10:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:58 INFO - 'LOGNAME': 'cltbld', 10:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:58 INFO - 'MOZ_NO_REMOTE': '1', 10:24:58 INFO - 'NO_EM_RESTART': '1', 10:24:58 INFO - 'PAGER': '/bin/cat', 10:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:58 INFO - 'PWD': '/builds/slave/test', 10:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:58 INFO - 'SHELL': '/bin/bash', 10:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:24:58 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:58 INFO - 'USER': 'cltbld', 10:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:58 INFO - 'XPC_FLAGS': '0x0', 10:24:58 INFO - 'XPC_SERVICE_NAME': '0', 10:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:58 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ldHtkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:58 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:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:58 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-BqFzVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:58 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:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:58 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-T1e6MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:58 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:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:58 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ZX_s8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:58 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:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:58 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-VY9cwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-FLsN1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-PXjOuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-_bkcLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-qxYB1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-wn_SkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-nQ67eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-QTu7p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-5FQOdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:59 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-BOuooK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:00 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-isijqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:00 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-jIuRaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:00 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-mDY_Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:03 INFO - Downloading blessings-1.6.tar.gz 10:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:25:03 INFO - Installing collected packages: blessings 10:25:03 INFO - Running setup.py install for blessings 10:25:03 INFO - Successfully installed blessings 10:25:03 INFO - Cleaning up... 10:25:03 INFO - Return code: 0 10:25:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:03 INFO - Reading from file tmpfile_stdout 10:25:03 INFO - Current package versions: 10:25:03 INFO - blessings == 1.6 10:25:03 INFO - blobuploader == 1.2.4 10:25:03 INFO - docopt == 0.6.1 10:25:03 INFO - functools32 == 3.2.3-2 10:25:03 INFO - jsonschema == 2.5.1 10:25:03 INFO - manifestparser == 1.1 10:25:03 INFO - mozInstall == 1.12 10:25:03 INFO - mozcrash == 1.0 10:25:03 INFO - mozdebug == 0.1 10:25:03 INFO - mozdevice == 0.48 10:25:03 INFO - mozfile == 1.2 10:25:03 INFO - mozhttpd == 0.7 10:25:03 INFO - mozinfo == 0.9 10:25:03 INFO - mozleak == 0.1 10:25:03 INFO - mozlog == 3.4 10:25:03 INFO - moznetwork == 0.27 10:25:03 INFO - mozprocess == 0.23 10:25:03 INFO - mozprofile == 0.28 10:25:03 INFO - mozrunner == 6.13 10:25:03 INFO - mozscreenshot == 0.1 10:25:03 INFO - mozsystemmonitor == 0.3 10:25:03 INFO - moztest == 0.7 10:25:03 INFO - mozversion == 1.4 10:25:03 INFO - psutil == 3.1.1 10:25:03 INFO - requests == 1.2.3 10:25:03 INFO - wsgiref == 0.1.2 10:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:03 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:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:03 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:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:03 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:25:03 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:25:03 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:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:03 INFO - 'HOME': '/Users/cltbld', 10:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:03 INFO - 'LOGNAME': 'cltbld', 10:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:03 INFO - 'MOZ_NO_REMOTE': '1', 10:25:03 INFO - 'NO_EM_RESTART': '1', 10:25:03 INFO - 'PAGER': '/bin/cat', 10:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:03 INFO - 'PWD': '/builds/slave/test', 10:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:03 INFO - 'SHELL': '/bin/bash', 10:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:25:03 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:03 INFO - 'USER': 'cltbld', 10:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:03 INFO - 'XPC_FLAGS': '0x0', 10:25:03 INFO - 'XPC_SERVICE_NAME': '0', 10:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 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:25:04 INFO - Cleaning up... 10:25:04 INFO - Return code: 0 10:25:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:25: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:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25: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:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:04 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 0x1102b2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110228570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a9c5fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, '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.iQmRCubdSM/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.C30EEM4q1T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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:25:04 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:25:04 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:25:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:25:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:04 INFO - 'HOME': '/Users/cltbld', 10:25:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:04 INFO - 'LOGNAME': 'cltbld', 10:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:04 INFO - 'MOZ_NO_REMOTE': '1', 10:25:04 INFO - 'NO_EM_RESTART': '1', 10:25:04 INFO - 'PAGER': '/bin/cat', 10:25:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:04 INFO - 'PWD': '/builds/slave/test', 10:25:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:04 INFO - 'SHELL': '/bin/bash', 10:25:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:25:04 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:25:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:04 INFO - 'USER': 'cltbld', 10:25:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:04 INFO - 'XPC_FLAGS': '0x0', 10:25:04 INFO - 'XPC_SERVICE_NAME': '0', 10:25:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:25:04 INFO - Cleaning up... 10:25:04 INFO - Return code: 0 10:25:04 INFO - Running post-action listener: _resource_record_post_action 10:25:04 INFO - Running post-action listener: _start_resource_monitoring 10:25:04 INFO - Starting resource monitoring. 10:25:04 INFO - [mozharness: 2016-11-22 18:25:04.339401Z] Finished create-virtualenv step (success) 10:25:04 INFO - [mozharness: 2016-11-22 18:25:04.340204Z] Running install step. 10:25:04 INFO - Running pre-action listener: _resource_record_pre_action 10:25:04 INFO - Running main action method: install 10:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:04 INFO - Reading from file tmpfile_stdout 10:25:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:25:04 INFO - Reading from file tmpfile_stdout 10:25:04 INFO - Output received: 10:25:04 INFO - Usage: mozinstall [options] installer 10:25:04 INFO - Options: 10:25:04 INFO - -h, --help show this help message and exit 10:25:04 INFO - -d DEST, --destination=DEST 10:25:04 INFO - Directory to install application into. [default: 10:25:04 INFO - "/builds/slave/test"] 10:25:04 INFO - --app=APP Application being installed. [default: firefox] 10:25:04 INFO - mkdir: /builds/slave/test/build/application 10:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:25:36 INFO - Reading from file tmpfile_stdout 10:25:36 INFO - Output received: 10:25:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:25:36 INFO - Running post-action listener: _resource_record_post_action 10:25:36 INFO - [mozharness: 2016-11-22 18:25:36.778831Z] Finished install step (success) 10:25:36 INFO - [mozharness: 2016-11-22 18:25:36.778981Z] Running run-tests step. 10:25:36 INFO - Running pre-action listener: _resource_record_pre_action 10:25:36 INFO - Running main action method: run_tests 10:25:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:36 INFO - 2016-11-22 10:25:36.793 screenresolution[1628:7524] starting screenresolution argv=screenresolution get 10:25:36 INFO - 2016-11-22 10:25:36.796 screenresolution[1628:7524] Display 0: 1600x1200x32@60 10:25:36 INFO - 2016-11-22 10:25:36.802 screenresolution[1629:7526] starting screenresolution argv=screenresolution list 10:25:36 INFO - Available Modes on Display 0 10:25:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:37 INFO - Intel Iris: 10:25:37 INFO - Chipset Model: Intel Iris 10:25:37 INFO - Type: GPU 10:25:37 INFO - Bus: Built-In 10:25:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:37 INFO - Vendor: Intel (0x8086) 10:25:37 INFO - Device ID: 0x0a2e 10:25:37 INFO - Revision ID: 0x0009 10:25:37 INFO - Displays: 10:25:37 INFO - Display: 10:25:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:37 INFO - Display Serial Number: 1600x1200 60 10:25:37 INFO - Main Display: Yes 10:25:37 INFO - Mirror: Off 10:25:37 INFO - Online: Yes 10:25:37 INFO - Rotation: Supported 10:25:37 INFO - Return code: 0 10:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:25:37 INFO - Python 2.7.3 10:25:37 INFO - Return code: 0 10:25:37 INFO - grabbing minidump binary from tooltool 10:25:37 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:25:37 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 0x1100c6d30>, '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 0x10ff2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:25:37 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:25:37 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:25:37 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:25:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:25:37 INFO - Return code: 0 10:25:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:25:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:25:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:25:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:25:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0372 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQmRCubdSM/Render', 10:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:37 INFO - 'HOME': '/Users/cltbld', 10:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:37 INFO - 'LOGNAME': 'cltbld', 10:25:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:25:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:37 INFO - 'MOZ_NO_REMOTE': '1', 10:25:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:25:37 INFO - 'NO_EM_RESTART': '1', 10:25:37 INFO - 'PAGER': '/bin/cat', 10:25:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:37 INFO - 'PWD': '/builds/slave/test', 10:25:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:37 INFO - 'SHELL': '/bin/bash', 10:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C30EEM4q1T/Listeners', 10:25:37 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 10:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:37 INFO - 'USER': 'cltbld', 10:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:37 INFO - 'XPC_FLAGS': '0x0', 10:25:37 INFO - 'XPC_SERVICE_NAME': '0', 10:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:25:37 INFO - mozversion application_buildid: 20161122080251 10:25:37 INFO - mozversion application_changeset: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 10:25:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:25:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:25:37 INFO - mozversion application_name: Firefox 10:25:37 INFO - mozversion application_remotingname: firefox-dev 10:25:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:25:37 INFO - mozversion application_vendor: Mozilla 10:25:37 INFO - mozversion application_version: 52.0a2 10:25:37 INFO - mozversion platform_buildid: 20161122080251 10:25:37 INFO - mozversion platform_changeset: 7ba0440fe03102f644bbe3f5c00923caa935d5e5 10:25:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:25:37 INFO - mozversion platform_version: 52.0a2 10:25:37 INFO - using testdate: 1479839137 10:25:37 INFO - actual date: 1479839137 10:25:37 INFO - starting webserver on 'localhost:49249' 10:25:37 INFO - SUITE-START | Running 2 tests 10:25:37 INFO - TEST-START | dromaeo_css 10:25:37 INFO - operating with platform_type : mac_ 10:25:37 INFO - Initialising browser for dromaeo_css test... 10:25:37 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmp1y5GV2/profile http://localhost:49249/getInfo.html) 10:25:38 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:25:39 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:25:39 INFO - PROCESS | 1639 | colorDepth:24 10:25:39 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:25:39 INFO - PROCESS | 1639 | __metrics 10:25:39 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:39 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:40 INFO - TEST-INFO | 1639: exit 0 10:25:40 INFO - Browser initialized. 10:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:25:40 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmp1y5GV2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:52 INFO - PROCESS | 1641 | RSS: Main: 217571328 10:25:52 INFO - PROCESS | 1641 | 10:26:43 INFO - PROCESS | 1641 | 1479839203958 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:28:57 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 10:28:58 INFO - PROCESS | 1641 | RSS: Main: 351125504 10:28:58 INFO - PROCESS | 1641 | 10:32:01 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 10:32:01 INFO - PROCESS | 1641 | RSS: Main: 345022464 10:32:01 INFO - PROCESS | 1641 | 10:35:04 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 10:35:05 INFO - PROCESS | 1641 | RSS: Main: 325169152 10:35:05 INFO - PROCESS | 1641 | 10:38:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 10:38:08 INFO - PROCESS | 1641 | RSS: Main: 326209536 10:38:08 INFO - PROCESS | 1641 | 10:41:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:41:12 INFO - PROCESS | 1641 | RSS: Main: 320536576 10:41:12 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:44:15 INFO - PROCESS | 1641 | RSS: Main: 376164352 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | __start_tp_report 10:44:15 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 10:44:15 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 10:44:15 INFO - PROCESS | 1641 | |i|pagename|runs| 10:44:15 INFO - PROCESS | 1641 | |0;dojo.html;3359.8488068036936;3371.4942758586217;3381.8478168482416;3416.5387672664183;3417.1115509967417;5679.744411501482;5712.771489140435;5752.626079304842;5756.453136951988;5775.133729940511;5673.744681489333;5752.712364381785;5765.6828874411995;5767.423257674231;5771.394003629611;5190.2474141249595;5216.452272511388;5218.582513398938;5233.947660523403;5267.078261304257;5165.586753059746;5179.715115668637;5307.363116426034;5311.097113490697;5312.256284120207;5171.250168725533;5196.896062078757;5205.16717325228;5235.633505654606;5248.239005344223;5230.372355317368;5249.291345668324;5251.186066159713;5292.894142117136;5298.09932311508;5229.189475631245;5230.607704422146;5263.499967503081;5278.498542638443;5310.60170487215;5623.297087864017;5624.353199382042;5663.915041274384;5666.603337766358;5681.204631351573;6174.629522228635;6201.689915504252;6226.470749986257;6237.844053898643;6251.281102673205;6219.906701399483;6260.843478913018;6291.7168727406915;6299.5905266158015;6302.306746257908;5717.971410142923;5762.423757624204;5826.679532625746;5848.853778655568;5871.295444546682;6238.812835614939;6256.249250090018;6271.811845644638;6282.465990390777;6286.245650521875;6187.319394866561;6193.597416168025;6194.690265486708;6198.907016394758;6211.937880621136;6154.969225153845;6210.813675589739;6238.625682459067;6252.093446450239;6276.184096067482;6203.565750397429;6244.812655620339;6281.7173227204885;6286.245650521967;6306.65313407767;6243.968780156161;6255.655938923403;6276.246850377893;6290.842728931813;6314.400131987454;4097.323941549671;4848.684835485682;4863.489333619989;4970.229614409773;4976.253561965734;4459.910801783946;4474.619657329164;4485.439320084989;4496.572825581565;4506.6169375602785;5745.339285982082;5767.394423585547;5767.769289228384;5782.277215348082;5784.739686714108;6217.875642487215;6219.968900155471;6233.625982441068;6243.032329988859;6287.622742635456;5859.091840764689;5863.501602363762;5880.941190588125;5893;5894.263217097863;5454.563634909197;5462.3445186577865;5462.672239665632;5468.453154684579;5479.068558345091;6162.661053642003;6212.658303793335;6215.223097112861;6220.471259942956;6312.684365781693;6277.058441233851;6281.309056003744;6289.874202515833;6301.464375528131;6315.273743519554;6316.115743795965;6322.557420980487;6328.430441260124;6330.588511746721;6334.113224148531;6104.938950610437;6131.835460087213;6139.938600613937;6246.3753624637175;6281.309056003927;6207.534434917489;6279.843003924939;6308.274548426806;6331.176946996861;6334.746610135543;6175.814725558241;6176.66028368444;6177.907331390123;6185.010398336244;6208.937910620836;5891.970540147443;5982.760689572368;6043.2748070231855;6148.538859585459;6155.2921414037955;5868.882622347614;5913.29040515141;5918.496927761188;5972.134040564007;5991.041433370639;5061.493850614909;6078.696065196811;6093.664848433379;6100.115483254992;6122.418370254819;5771.3651498335985;5794.594378393641;5927.525797936241;5958.374370691188;5960.314563825215 10:44:15 INFO - PROCESS | 1641 | |1;ext.html;464.94653114891787;494.8441241009082;520.6979951628056;527.2328761651795;547.7019463870628;29194.854025729866;38179;39293.41059884097;39418.80290598543;41117.794411027906;39780.00549986252;39996.40005399921;40477.79761101198;40532.59467405325;40614.59385406145;9115.316351273648;9294.349395542315;9295.628174872996;9299.767505812375;9301.162895339452;8435.987681478231;8812.691555795549;9194.172524472797;9297.209737172348;9305.534723263843;9270;9318.347715659873;9323.114304141096;9343.159115679588;9399.906000940005;8582.570871456433;8622.267107295856;9146.222571081466;9307.255419566418;9312.301577381724;9171.449713017173;9255.074492550759;9262.16640502358;9263.675771347971;9265.980742118361;38422.80788596067;38700;38746.80626596849;38783.836484905216;38952.80523597364;3288.4574045282498;3445.586529616437;3517.4899639552377;3556.893293201182;3655.5796083450477;24544.509109817704;25693.48613027729;30153.396932061456;30329.69670303313;30715.69284307173;3198.648148703664;3217.871285148591;3244.5619841321354;3245.6592057833823;3246.5130230465384;493020;502819;503981;504463;516338;62986;64533.35466645368;64543.67728161423;64588;64625.38436539124;32657.836710816293;35950.92147235587;36176;63626.68186659037;68767.96848047283;16189.190540473164;16567.17164141788;16593.41923032688;16600.750988735177;16631.417900373428;12563.560275390317;12654.746905062031;12659.556915508098;12668.619941401772;12677.302748348744;19714.70427943582;19817.900910495642;19993.800061999194;20043.298484553263;20056;8069.757907262791;8152.084260198849;8152.592370381457;8163.0612479564425;8231.547264900488;835.6532039203662;911.6353458616474;927.4852456886358;963.7157038673608;1085.5766251162054;27763.583546246824;28229;28790.71209287922;29006.709932900823;29119;678.5352033856824;1020.5713600287897;1064.627380416848;1089.716673664837;1132.773445310941;14496.637584060483;14928.40286388554;15005.624859378384;15350.232488375537;15376.538703838904;704315.9568404353;714244;715328;716498;720050;55009.449905500434;55549.44450555443;55588;55672.44327556673;55697.443025570035;1206.4329765010432;1244.875512448748;1360.9455621775217;1430.9983011891718;1538.7307221236463;28796.280092997844;30366.089017329516;30436.086917392513;30556.541651875683;31086.184962800493;47456.288155677;48500;48513.757431212616;48535.271970919755;48547.02905941932;621783;632331;634000;635220;637968;40237.798811005756;41018.38472422856;41271.1745765077;42461.78769106135;43174.136517270104;41503.96240094022;44794;44937;45195.774021129684;45733;36756.44865326969;36964.07589810276;37167.814160929025;37501.74070463737;38343.808280959536;36894.077648059014;37257.813710931274;38161.42757858579;38178;38205.23589528138;36077.81961090178;36352.81823590971;36738.71414500479;37154.25691486101;37483.625163748016;31505.527417088302;32660.693572256845;33126.668733312355;33145.33709325848;33269.50095748517;24140;24609.876950615133;24675.8766206175;24856.502869942862;25329.74670253274 10:44:15 INFO - PROCESS | 1641 | |2;jquery.html;353.82662495377275;367.963203679632;369.95930447650755;383.6642937429749;402.9113595009099;14690.926545367272;15169.924150379247;20215.787052776825;20594.691079633816;21389.67915481269;19905.104270307835;20076.69884951727;20149.697754533656;20655.380338589865;20848.791512084874;5713.17159011943;5912.822615321547;5966.79116230932;5967.134765459005;5977.43214394634;5151.175811870102;5183.50756678115;5564.527015203713;5914.9408505915035;6040.96979515104;5842.766289348421;5953.70231488426;5956.791512297071;5963.55273354498;5970.432808883149;5739.913901291463;5935.584509084366;5960.79137230197;5986.341502434729;5990.371011043821;5159.664621799571;5347.358317001946;5694.886102277931;5784.566157538159;5788.334341550733;23512.412189695224;24543.754562454327;24689.876550617133;25077.749222507722;25673.101441449646;2129.9148034078617;2161.070739581979;2222.376691856237;2386.7613238675995;2586.4180559374176;9326.253899688008;10422.478876056166;10804.1896857736;11358.94320528392;15871.841281587152;1747.6679430908086;1806.2413786209822;1875.3623767918973;1886.9245230190777;1926.6917293233016;106022;125581.37209313986;127306.53171403479;132288;133882;11316.26444281119;11577.131715121399;11768.470418831173;11838.526458941546;12189.51241950312;12860.292683902288;13504.86495135036;13657.521986730417;13680.794788078187;14380.496682616058;8388.454750441202;8468.110848360957;8470.237678608955;8572.399932004824;8587.313014958789;8332.208440198292;8360.958195208985;8378.790530236793;8530.914690853137;8531.402801803939;4460.018795864905;4550.863474095782;4555.2711566149255;4624.884377890579;4645.0477652081245;1652.5290292266645;1862.5565186979927;1916.9233230670895;1935.7289979402894;1946.7274581558593;766.8504641594947;873.7466134820958;907.8865141857268;941;1014.2798612984864;20366.490837728878;21277.78722212758;21431.357059288246;21471.03380347888;21602.135914563554;744.7207297263526;926.4533924984291;929.5677509957902;942.8632848236967;948.0186410402155;10598.788024239471;11234.213605047567;11245.493952772145;11248.887511124783;11253.887461125283;518875;575416;582637;590111;592303;125328;131265;131973;134420;134851;950.102153464969;958.8274110660149;971.4705485510414;974.1622204903778;976.3556053004983;17892.46322610324;18516.259349625863;18903.716444253623;18958.715619265447;19007.619847603248;36713.44929826108;48470.54588362355;50001.74999124981;51142.48857511377;52533;70426.64786676034;70473.64763176152;71934.28065719276;72068.63965680137;72118.63940680263;7782.684276779809;7996.41550294965;8344.916550834414;8438.071812100541;8596.656133754579;10615.469226538797;12407.75184496287;12966;13116.278604676834;13434.865651343362;10906.61826836057;11274.210805243554;11307.265027773168;11327.603533876274;11559.190856639954;10743.462826858782;10922.399268040333;11005.779884402427;11197;11326.716832079264;10595.470226488798;11270.887291126985;11333.546658133582;11595.304281743123;11653.941730291293;8079.434439589172;8091.352691784761;8202.548859812767;8278.917210828056;8506.61720222579;8154.75535733929;10546.683599492027;10911;11173.720656983316;11239.719007024889 10:44:15 INFO - PROCESS | 1641 | |3;mootools.html;1308.960731178065;1481.7925490431342;1506.9397224111035;1657;1817.2004318100035;7490.475666703326;7900.367970562348;7901.091374491935;7915.960420197898;7917.960410197956;7720.845583088335;8201.466904651208;8404.411691181604;8423.95788021059;8553.230209281164;2325.883705814711;2353.9411514712097;2356.234223877238;2357.6227803551437;2362.090595120874;2326.174208156097;2373.905043798246;2379.4527258730504;2380.9166679166233;2385.2128797496785;2313.3406979010983;2318.733345665245;2342.894569744357;2349.565330413879;2356.9410764730846;2295;2300.1489448903844;2330.5571941331177;2332.8250381221305;2341.4848733278823;2340.1926335414255;2364.397078744909;2365.929022129339;2366.514864452783;2375.5130198309307;8447.32421406286;8501.149885011511;8555.443896146793;8573;8586.484810911365;4644.698094623838;4742.549457801503;5249.317588713481;5255.816046438356;5261.684298942076;3253.869845206189;3468.5490886184634;3654.6710796028483;3659.5608526976935;3660.3045421369857;1053.6891616972935;1076.6339444588798;1102.366139469808;1116.6426743442103;1118.6028959719263;11078.501467433985;11290.26613270143;11295;11310.37792921389;11312.66062018149;4362;4433.866983990485;4517.277235642281;4774.522547745198;4783.641226907996;9749.415035097916;9754.219662426989;9755.122039016522;9760.121589057018;9806.558704858298;5262.447443018505;5293.735313234323;5296.285001524822;5304.522592966651;5307.363116426053;4617.976910115495;4719.5752382285755;4753.025629745894;4829.492903245179;4838.056578967067;3678.4850120983083;3706.425504046877;3779.1874746929543;3817.141143242748;3848.9230215395537;1189.5241903238773;1221.9205751626293;1222.4865556466304;1235.9011279097651;1245.6014075495937;860.2043110123111;868.5700578213698;891.888513935758;899.0470101692097;912.2337236721186;5451.972740136274;5469.097598896217;5565.1374037024325;5716.599028408079;5823.359430462646;441.14858323435436;449.0905915521096;449.6200710399707;462.77555385637936;462.85651448051215;3663.46879702447;3780.7353485256317;3820.178661587772;3828.349180639298;3845.307844587945;8029.959850200712;9231.584578693975;9645.37305075168;10390.636327728493;10393.168546516412;7696.191899850435;9654.27592930533;9732.172765314886;10066.597336106473;10232.23258255619;7657.885131723028;7736.961315193501;7788.532688038736;7790.220977902278;7941.285284324323;5677.8864422710485;5706.657600543981;5714.342850572238;5733.483986441241;5761.711914404179;9149.405288656217;9395;9467.905320946978;9580.856287155559;9616.471094089893;9549.188318992685;9583.712488625353;9676.70969870905;9762.658306959222;9848.950755246178;6998.405135563534;7101.680424380812;7151.141862976268;7170.498065135391;7301.306375894282;7861.52830830152;8027.919720802951;8032.959835200787;8034.995625546807;8035.959820200862;7150.7497237596435;7268.600226987355;7286.599237042014;7320.487565870338;7406.481546291708;7099.467539934629;7128.581276439529;7135.108111486064;7166.605836679033;7200.279972002758;5704.686242256716;6687;6727.899081513683;6750.696218670073;6824.351686589766;4869.050535145612;4888.608911287018;4915.705057696549;4960.677555958851;4999.10016197088;4217.91564168721;4804.759762011955;4871.464138944784;4914.311996320589;4996.3005179274205 10:44:15 INFO - PROCESS | 1641 | |4;prototype.html;249.48481385938035;262.9815912886098;302.4933236828313;308.60806775395247;314.6381661089748;4906.528041587528;5106.7446627668605;5108.667936584119;5179.559737422319;5206.29714988476;4447.866564003077;4629.7222166669935;4939.332760309438;5036;5048.066107770056;3490.7207423406194;3531.0452293431395;3886.5919078496777;3899.401245489357;3902.8829135125848;3612.1644509060393;3819.2934307153128;3918.157596116834;3929.960700392988;3950.7629542227414;3832.310184166849;3874.9850077959445;3880.5149356330458;3906.277338692351;3921.4117882317596;3364.2598628301735;3801.9434152577005;3864.516935383091;3865.5747867734526;3893;3449.741269404805;3451.4132597458492;3453.6028356739043;3454.5336379588935;3456.7753096048677;4118.537919038728;4333.71830830995;4903.583195428393;4924.75376231187;4942.431620363668;3892.7811147645853;4390.956090439086;4469.262571675669;4487.259602165639;4487.326900964848;4029.8589549365634;4493.932591011137;5051.722155281458;5352.598555108382;5388.272583201296;3196.488561830096;3489.2672538766888;3518.7712798668003;3813.694904407641;3829;5547.389787123454;5547.696291371524;5554.444555544454;5564.33228012641;5586.41342659019;3233.8196558256536;3354.859347821752;3699.445083237482;3847.788371639587;3856.7107466940092;3315.5192497087787;3531.788092714445;3781.6029316921877;3939.4484772131923;3949.940750888739;3949.822257998397;4042.0501182222743;4303.794937417466;4333.393324934512;4523.185826551186;4465.709728867613;5342.572594192456;5352.892942141136;5353.411124776271;5375.220593013991;1151.7696460707891;1184.461070213051;1207.710149564116;1223.9877601224052;1245.1221888568537;861.401326078382;878.4290211362666;881.0308660473556;886.9379143460025;886.9600867960958;4145.2124096422185;4590.816367345269;4751.099560175957;4766.499517550607;4781.713097214179;4403.4495688039;5028.622853285945;5041.909334172779;5191.9480805192225;5223.13818219997;4435.4233949587;4605.815767369335;4626.357643036674;4666.789994450258;4697.553732395417;2394.521095780851;2657.0036236411347;2675.2375572961614;2685.2883985743792;2705.837649741022;4566.511251367946;4793.23308270675;5297.655652382583;5325.4674532547215;5341.596281673263;4634.443866736014;5277.894442111213;5283.833628212491;5285.445028271976;5310.628256022119;4611.371518234574;4684.844971313234;4941.876453088629;5315.468453154808;5325.840224793263;4204.393276168673;4383.189110014658;4561.471906911222;4625.653076019379;4947.851564453073;5050.469700681376;5079.917233934217;5080.872978175576;5101.668391554537;5118.769655365592;4125.443065186161;4265.808038638331;5200.959808038332;5209.010288045411;5259.396598683676;2985.447692176954;3406.846691898821;3575.0863046616923;3637.2907283079544;3641.344557979589;4443.178012067778;4582.656300777388;4705.564802735199;4980.750962451791;5140.665856719302;4703.576678098988;4979.626528010342;5000.974605284866;5012.122878496321;5019.749012549285;4620.468646105606;4768.38011058574;4973.538098641196;4975.452700203047;4981.37732783402;4253.8723838284905;4583.427071616048;4776.402949631296;4952.5542701157065;5115.411727651368;4258.615175501729;4716.221823399101;4745.928811067905;5324.574034077187;5350.652207606493;4452.755098469615;5204.843854684365;5219.556337711337;5225.92161117576;5303.196913049582 10:44:15 INFO - PROCESS | 1641 | |5;yui.html;626.555145846449;659.4394764450218;691.2568988337537;706.604301591109;763.1071646173974;13931.37308821103;14594.927025364885;14653.853461465382;14654.19401932892;14736.410543578271;12857.807132892991;12932.870671293284;12956;12970.286634235114;12973.870261297385;638.7061951502315;664.060354598243;664.3356643356643;814.0597609760736;833.1959658929133;797.9401544884128;807.446898874273;819.5820131732829;822.6215940667271;825.63671984327;873.388627960427;876.7851876290285;877.5392918717693;880.7093659092516;881.2949640287776;687.9312068793131;712.2094475132599;872.3195907192337;872.3370238618633;872.9301655867515;627.8555932135589;645.096864389858;645.4223469994375;646.647577070493;649.4447247603325;13490.190588564717;13840.93079534596;13874.236916969563;13914.721705565933;13925.791113133311;12423.3788310585;12652.873471265262;12743.553975610901;12767.361631918367;12817.87182128176;9946.154576860976;10067.89932100677;10434.791304173874;12018.39908004605;12059.155859089868;4373.934390984138;4411.228035093878;4412.977935110304;4479.10417916418;4570.794314255866;92317.5384123075;93063.60404593937;93384.53307733418;94688;95299;9634.518274086267;10091.243156763272;10246.231532634933;10255.794884102275;10520.789584208273;19251.903740481488;19985;20081.698774518394;20141;20475;7523.322900938832;7677;7699.961500192575;7742.458027937991;7787.143414224431;4179.707420480538;4227.830886764556;4248.596383343577;4430.379746835446;4478.2386994211065;3429.1255729788745;3544.9822750886597;3546.769459985093;3549.893503194908;3556.6621170988715;652.1456891472187;658.9242237142694;664.7407511070686;674.7368526274756;677.7153595489906;600.3906035374099;660.1352228580574;665.5376296164203;671.1476424940298;695.4575431163701;8750.124987501198;8865.734027979172;8908.777280567909;9259.814803704023;9463.668771592962;639.8144538083997;652.6051738698114;665.9640893955346;667.68952437116;677.7864972533735;4246.617804397619;4466.441694788152;4514.6388288936805;4522.547745225517;4580.1984652686315;97236.51381743046;122582;123870;124997.37501312436;125972;78951;100927.49536252272;102270.48864755778;108124.4593777026;110416;92672.82972266265;94564;96542;97337;97607.51196244116;8844.911550884666;8854.24738897201;8884;8884.911150888409;8916.68791592317;60505.69747151236;60982.69508652428;61325.693371532856;62102.68948655228;63695;65951;88010.67983980374;88608.67086993829;89320.10679893378;90241;10875.945620271848;11090.889091109308;11264.94367528157;11372.43137843121;11439.42802859837;12141.878581214074;12166.513339466323;12318.630441086782;12387.07096967713;12471.064670149593;11378.08975281992;11948.223365481215;11982.041436684869;12449.883519801475;12475;11997.280163190237;12001.099917506397;12299.69250768738;12475.376231188222;12480.875191247971;11552.59565915189;11792.997595204504;11837.940810295893;12245.632631021084;12350.876491234972;9296.629359513281;9514.762130946781;10024.890481879496;10087.04173103554;10202.571639970261;9838.06538378853;10175.185985121025;10200.4389758564;10207.89792102099;10210.795784084425 10:44:15 INFO - PROCESS | 1641 | __end_tp_report 10:44:15 INFO - PROCESS | 1641 | __start_cc_report 10:44:15 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1452 10:44:15 INFO - PROCESS | 1641 | __end_cc_report 10:44:15 INFO - PROCESS | 1641 | __startTimestamp1479840255553__endTimestamp 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | ------- Summary: start ------- 10:44:15 INFO - PROCESS | 1641 | Number of tests: 6 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5761.04 Median:5927.53 stddev:642.60 (10.8%) stddev-sans-first:616.35 10:44:15 INFO - PROCESS | 1641 | Values: 3359.8 3371.5 3381.8 3416.5 3417.1 5679.7 5712.8 5752.6 5756.5 5775.1 5673.7 5752.7 5765.7 5767.4 5771.4 5190.2 5216.5 5218.6 5233.9 5267.1 5165.6 5179.7 5307.4 5311.1 5312.3 5171.3 5196.9 5205.2 5235.6 5248.2 5230.4 5249.3 5251.2 5292.9 5298.1 5229.2 5230.6 5263.5 5278.5 5310.6 5623.3 5624.4 5663.9 5666.6 5681.2 6174.6 6201.7 6226.5 6237.8 6251.3 6219.9 6260.8 6291.7 6299.6 6302.3 5718.0 5762.4 5826.7 5848.9 5871.3 6238.8 6256.2 6271.8 6282.5 6286.2 6187.3 6193.6 6194.7 6198.9 6211.9 6155.0 6210.8 6238.6 6252.1 6276.2 6203.6 6244.8 6281.7 6286.2 6306.7 6244.0 6255.7 6276.2 6290.8 6314.4 4097.3 4848.7 4863.5 4970.2 4976.3 4459.9 4474.6 4485.4 4496.6 4506.6 5745.3 5767.4 5767.8 5782.3 5784.7 6217.9 6220.0 6233.6 6243.0 6287.6 5859.1 5863.5 5880.9 5893.0 5894.3 5454.6 5462.3 5462.7 5468.5 5479.1 6162.7 6212.7 6215.2 6220.5 6312.7 6277.1 6281.3 6289.9 6301.5 6315.3 6316.1 6322.6 6328.4 6330.6 6334.1 6104.9 6131.8 6139.9 6246.4 6281.3 6207.5 6279.8 6308.3 6331.2 6334.7 6175.8 6176.7 6177.9 6185.0 6208.9 5892.0 5982.8 6043.3 6148.5 6155.3 5868.9 5913.3 5918.5 5972.1 5991.0 5061.5 6078.7 6093.7 6100.1 6122.4 5771.4 5794.6 5927.5 5958.4 5960.3 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:73709.92 Median:39356.11 stddev:167013.26 (424.4%) stddev-sans-first:167391.23 10:44:15 INFO - PROCESS | 1641 | Values: 464.9 494.8 520.7 527.2 547.7 29194.9 38179.0 39293.4 39418.8 41117.8 39780.0 39996.4 40477.8 40532.6 40614.6 9115.3 9294.3 9295.6 9299.8 9301.2 8436.0 8812.7 9194.2 9297.2 9305.5 9270.0 9318.3 9323.1 9343.2 9399.9 8582.6 8622.3 9146.2 9307.3 9312.3 9171.4 9255.1 9262.2 9263.7 9266.0 38422.8 38700.0 38746.8 38783.8 38952.8 3288.5 3445.6 3517.5 3556.9 3655.6 24544.5 25693.5 30153.4 30329.7 30715.7 3198.6 3217.9 3244.6 3245.7 3246.5 493020.0 502819.0 503981.0 504463.0 516338.0 62986.0 64533.4 64543.7 64588.0 64625.4 32657.8 35950.9 36176.0 63626.7 68768.0 16189.2 16567.2 16593.4 16600.8 16631.4 12563.6 12654.7 12659.6 12668.6 12677.3 19714.7 19817.9 19993.8 20043.3 20056.0 8069.8 8152.1 8152.6 8163.1 8231.5 835.7 911.6 927.5 963.7 1085.6 27763.6 28229.0 28790.7 29006.7 29119.0 678.5 1020.6 1064.6 1089.7 1132.8 14496.6 14928.4 15005.6 15350.2 15376.5 704316.0 714244.0 715328.0 716498.0 720050.0 55009.4 55549.4 55588.0 55672.4 55697.4 1206.4 1244.9 1360.9 1431.0 1538.7 28796.3 30366.1 30436.1 30556.5 31086.2 47456.3 48500.0 48513.8 48535.3 48547.0 621783.0 632331.0 634000.0 635220.0 637968.0 40237.8 41018.4 41271.2 42461.8 43174.1 41504.0 44794.0 44937.0 45195.8 45733.0 36756.4 36964.1 37167.8 37501.7 38343.8 36894.1 37257.8 38161.4 38178.0 38205.2 36077.8 36352.8 36738.7 37154.3 37483.6 31505.5 32660.7 33126.7 33145.3 33269.5 24140.0 24609.9 24675.9 24856.5 25329.7 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34208.21 Median:24883.81 stddev:96008.22 (385.8%) stddev-sans-first:96243.90 10:44:15 INFO - PROCESS | 1641 | Values: 353.8 368.0 370.0 383.7 402.9 14690.9 15169.9 20215.8 20594.7 21389.7 19905.1 20076.7 20149.7 20655.4 20848.8 5713.2 5912.8 5966.8 5967.1 5977.4 5151.2 5183.5 5564.5 5914.9 6041.0 5842.8 5953.7 5956.8 5963.6 5970.4 5739.9 5935.6 5960.8 5986.3 5990.4 5159.7 5347.4 5694.9 5784.6 5788.3 23512.4 24543.8 24689.9 25077.7 25673.1 2129.9 2161.1 2222.4 2386.8 2586.4 9326.3 10422.5 10804.2 11358.9 15871.8 1747.7 1806.2 1875.4 1886.9 1926.7 106022.0 125581.4 127306.5 132288.0 133882.0 11316.3 11577.1 11768.5 11838.5 12189.5 12860.3 13504.9 13657.5 13680.8 14380.5 8388.5 8468.1 8470.2 8572.4 8587.3 8332.2 8361.0 8378.8 8530.9 8531.4 4460.0 4550.9 4555.3 4624.9 4645.0 1652.5 1862.6 1916.9 1935.7 1946.7 766.9 873.7 907.9 941.0 1014.3 20366.5 21277.8 21431.4 21471.0 21602.1 744.7 926.5 929.6 942.9 948.0 10598.8 11234.2 11245.5 11248.9 11253.9 518875.0 575416.0 582637.0 590111.0 592303.0 125328.0 131265.0 131973.0 134420.0 134851.0 950.1 958.8 971.5 974.2 976.4 17892.5 18516.3 18903.7 18958.7 19007.6 36713.4 48470.5 50001.7 51142.5 52533.0 70426.6 70473.6 71934.3 72068.6 72118.6 7782.7 7996.4 8344.9 8438.1 8596.7 10615.5 12407.8 12966.0 13116.3 13434.9 10906.6 11274.2 11307.3 11327.6 11559.2 10743.5 10922.4 11005.8 11197.0 11326.7 10595.5 11270.9 11333.5 11595.3 11653.9 8079.4 8091.4 8202.5 8278.9 8506.6 8154.8 10546.7 10911.0 11173.7 11239.7 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5455.09 Median:5124.21 stddev:3009.14 (58.7%) stddev-sans-first:3001.45 10:44:15 INFO - PROCESS | 1641 | Values: 1309.0 1481.8 1506.9 1657.0 1817.2 7490.5 7900.4 7901.1 7916.0 7918.0 7720.8 8201.5 8404.4 8424.0 8553.2 2325.9 2353.9 2356.2 2357.6 2362.1 2326.2 2373.9 2379.5 2380.9 2385.2 2313.3 2318.7 2342.9 2349.6 2356.9 2295.0 2300.1 2330.6 2332.8 2341.5 2340.2 2364.4 2365.9 2366.5 2375.5 8447.3 8501.1 8555.4 8573.0 8586.5 4644.7 4742.5 5249.3 5255.8 5261.7 3253.9 3468.5 3654.7 3659.6 3660.3 1053.7 1076.6 1102.4 1116.6 1118.6 11078.5 11290.3 11295.0 11310.4 11312.7 4362.0 4433.9 4517.3 4774.5 4783.6 9749.4 9754.2 9755.1 9760.1 9806.6 5262.4 5293.7 5296.3 5304.5 5307.4 4618.0 4719.6 4753.0 4829.5 4838.1 3678.5 3706.4 3779.2 3817.1 3848.9 1189.5 1221.9 1222.5 1235.9 1245.6 860.2 868.6 891.9 899.0 912.2 5452.0 5469.1 5565.1 5716.6 5823.4 441.1 449.1 449.6 462.8 462.9 3663.5 3780.7 3820.2 3828.3 3845.3 8030.0 9231.6 9645.4 10390.6 10393.2 7696.2 9654.3 9732.2 10066.6 10232.2 7657.9 7737.0 7788.5 7790.2 7941.3 5677.9 5706.7 5714.3 5733.5 5761.7 9149.4 9395.0 9467.9 9580.9 9616.5 9549.2 9583.7 9676.7 9762.7 9849.0 6998.4 7101.7 7151.1 7170.5 7301.3 7861.5 8027.9 8033.0 8035.0 8036.0 7150.7 7268.6 7286.6 7320.5 7406.5 7099.5 7128.6 7135.1 7166.6 7200.3 5704.7 6687.0 6727.9 6750.7 6824.4 4869.1 4888.6 4915.7 4960.7 4999.1 4217.9 4804.8 4871.5 4914.3 4996.3 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4162.43 Median:4587.12 stddev:1236.56 (27.0%) stddev-sans-first:1204.65 10:44:15 INFO - PROCESS | 1641 | Values: 249.5 263.0 302.5 308.6 314.6 4906.5 5106.7 5108.7 5179.6 5206.3 4447.9 4629.7 4939.3 5036.0 5048.1 3490.7 3531.0 3886.6 3899.4 3902.9 3612.2 3819.3 3918.2 3930.0 3950.8 3832.3 3875.0 3880.5 3906.3 3921.4 3364.3 3801.9 3864.5 3865.6 3893.0 3449.7 3451.4 3453.6 3454.5 3456.8 4118.5 4333.7 4903.6 4924.8 4942.4 3892.8 4391.0 4469.3 4487.3 4487.3 4029.9 4493.9 5051.7 5352.6 5388.3 3196.5 3489.3 3518.8 3813.7 3829.0 5547.4 5547.7 5554.4 5564.3 5586.4 3233.8 3354.9 3699.4 3847.8 3856.7 3315.5 3531.8 3781.6 3939.4 3949.9 3949.8 4042.1 4303.8 4333.4 4523.2 4465.7 5342.6 5352.9 5353.4 5375.2 1151.8 1184.5 1207.7 1224.0 1245.1 861.4 878.4 881.0 886.9 887.0 4145.2 4590.8 4751.1 4766.5 4781.7 4403.4 5028.6 5041.9 5191.9 5223.1 4435.4 4605.8 4626.4 4666.8 4697.6 2394.5 2657.0 2675.2 2685.3 2705.8 4566.5 4793.2 5297.7 5325.5 5341.6 4634.4 5277.9 5283.8 5285.4 5310.6 4611.4 4684.8 4941.9 5315.5 5325.8 4204.4 4383.2 4561.5 4625.7 4947.9 5050.5 5079.9 5080.9 5101.7 5118.8 4125.4 4265.8 5201.0 5209.0 5259.4 2985.4 3406.8 3575.1 3637.3 3641.3 4443.2 4582.7 4705.6 4980.8 5140.7 4703.6 4979.6 5001.0 5012.1 5019.7 4620.5 4768.4 4973.5 4975.5 4981.4 4253.9 4583.4 4776.4 4952.6 5115.4 4258.6 4716.2 4745.9 5324.6 5350.7 4452.8 5204.8 5219.6 5225.9 5303.2 10:44:15 INFO - PROCESS | 1641 | 10:44:15 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:21619.77 Median:4546.67 stddev:33063.69 (727.2%) stddev-sans-first:33118.86 10:44:15 INFO - PROCESS | 1641 | Values: 626.6 659.4 691.3 706.6 763.1 13931.4 14594.9 14653.9 14654.2 14736.4 12857.8 12932.9 12956.0 12970.3 12973.9 638.7 664.1 664.3 814.1 833.2 797.9 807.4 819.6 822.6 825.6 873.4 876.8 877.5 880.7 881.3 687.9 712.2 872.3 872.3 872.9 627.9 645.1 645.4 646.6 649.4 13490.2 13840.9 13874.2 13914.7 13925.8 12423.4 12652.9 12743.6 12767.4 12817.9 9946.2 10067.9 10434.8 12018.4 12059.2 4373.9 4411.2 4413.0 4479.1 4570.8 92317.5 93063.6 93384.5 94688.0 95299.0 9634.5 10091.2 10246.2 10255.8 10520.8 19251.9 19985.0 20081.7 20141.0 20475.0 7523.3 7677.0 7700.0 7742.5 7787.1 4179.7 4227.8 4248.6 4430.4 4478.2 3429.1 3545.0 3546.8 3549.9 3556.7 652.1 658.9 664.7 674.7 677.7 600.4 660.1 665.5 671.1 695.5 8750.1 8865.7 8908.8 9259.8 9463.7 639.8 652.6 666.0 667.7 677.8 4246.6 4466.4 4514.6 4522.5 4580.2 97236.5 122582.0 123870.0 124997.4 125972.0 78951.0 100927.5 102270.5 108124.5 110416.0 92672.8 94564.0 96542.0 97337.0 97607.5 8844.9 8854.2 8884.0 8884.9 8916.7 60505.7 60982.7 61325.7 62102.7 63695.0 65951.0 88010.7 88608.7 89320.1 90241.0 10875.9 11090.9 11264.9 11372.4 11439.4 12141.9 12166.5 12318.6 12387.1 12471.1 11378.1 11948.2 11982.0 12449.9 12475.0 11997.3 12001.1 12299.7 12475.4 12480.9 11552.6 11793.0 11837.9 12245.6 12350.9 9296.6 9514.8 10024.9 10087.0 10202.6 9838.1 10175.2 10200.4 10207.9 10210.8 10:44:15 INFO - PROCESS | 1641 | -------- Summary: end -------- 10:44:15 INFO - PROCESS | 1641 | 10:44:16 INFO - TEST-INFO | 1641: exit 0 10:44:16 INFO - TEST-OK | dromaeo_css | took 1118826ms 10:44:16 INFO - TEST-START | kraken 10:44:16 INFO - operating with platform_type : mac_ 10:44:16 INFO - Initialising browser for kraken test... 10:44:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpRvkkD_/profile http://localhost:49249/getInfo.html) 10:44:17 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:44:18 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:44:18 INFO - PROCESS | 1651 | colorDepth:24 10:44:18 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:44:18 INFO - PROCESS | 1651 | __metrics 10:44:18 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:44:18 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:44:19 INFO - TEST-INFO | 1651: exit 0 10:44:19 INFO - Browser initialized. 10:44:19 INFO - Running cycle 1/1 for kraken test... 10:44:19 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpRvkkD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:44:31 INFO - PROCESS | 1652 | RSS: Main: 217526272 10:44:31 INFO - PROCESS | 1652 | 10:44:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:44:34 INFO - PROCESS | 1652 | RSS: Main: 267149312 10:44:34 INFO - PROCESS | 1652 | 10:44:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:44:38 INFO - PROCESS | 1652 | RSS: Main: 278355968 10:44:38 INFO - PROCESS | 1652 | 10:44:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:44:42 INFO - PROCESS | 1652 | RSS: Main: 373641216 10:44:42 INFO - PROCESS | 1652 | 10:44:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:44:44 INFO - PROCESS | 1652 | RSS: Main: 278745088 10:44:44 INFO - PROCESS | 1652 | 10:44:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:44:47 INFO - PROCESS | 1652 | RSS: Main: 280276992 10:44:47 INFO - PROCESS | 1652 | 10:44:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:44:50 INFO - PROCESS | 1652 | RSS: Main: 320552960 10:44:50 INFO - PROCESS | 1652 | 10:44:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:44:54 INFO - PROCESS | 1652 | RSS: Main: 320278528 10:44:54 INFO - PROCESS | 1652 | 10:44:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:44:57 INFO - PROCESS | 1652 | RSS: Main: 318881792 10:44:57 INFO - PROCESS | 1652 | 10:44:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:44:59 INFO - PROCESS | 1652 | RSS: Main: 296386560 10:44:59 INFO - PROCESS | 1652 | 10:45:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:45:02 INFO - PROCESS | 1652 | RSS: Main: 295137280 10:45:02 INFO - PROCESS | 1652 | 10:45:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:45:04 INFO - PROCESS | 1652 | RSS: Main: 298500096 10:45:04 INFO - PROCESS | 1652 | 10:45:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:45:08 INFO - PROCESS | 1652 | RSS: Main: 318021632 10:45:08 INFO - PROCESS | 1652 | 10:45:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:45:12 INFO - PROCESS | 1652 | RSS: Main: 311353344 10:45:12 INFO - PROCESS | 1652 | 10:45:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:45:14 INFO - PROCESS | 1652 | RSS: Main: 354938880 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | __start_tp_report 10:45:14 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:45:14 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:45:14 INFO - PROCESS | 1652 | |i|pagename|runs| 10:45:14 INFO - PROCESS | 1652 | |0;ai-astar;114;114;114;113;113;112;113;114;114;113 10:45:14 INFO - PROCESS | 1652 | |1;audio-beat-detection;169;140;123;146;114;113;112;117;174;140 10:45:14 INFO - PROCESS | 1652 | |2;audio-dft;184;183;184;185;187;181;185;185;183;185 10:45:14 INFO - PROCESS | 1652 | |3;audio-fft;79;65;81;111;89;59;60;58;82;58 10:45:14 INFO - PROCESS | 1652 | |4;audio-oscillator;88;70;94;72;67;68;89;68;70;92 10:45:14 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;85;87;86;88;84;88;85;88;85 10:45:14 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;93;94;101;124;93;94;93;94 10:45:14 INFO - PROCESS | 1652 | |7;imaging-desaturate;83;80;81;86;81;82;84;83;84;84 10:45:14 INFO - PROCESS | 1652 | |8;json-parse-financial;57;55;56;55;57;55;56;57;58;57 10:45:14 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;64;74;75;74;73;68;69;69;69;72 10:45:14 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;84;81;83;84;84;84;82;84;85;85 10:45:14 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;146;154;135;156;142;157;157;157;189;161 10:45:14 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;164;166;166;167;215;159;209;201;165;164 10:45:14 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;67;67;66;65;65;65;64;65;65 10:45:14 INFO - PROCESS | 1652 | __end_tp_report 10:45:14 INFO - PROCESS | 1652 | __start_cc_report 10:45:14 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1967 10:45:14 INFO - PROCESS | 1652 | __end_cc_report 10:45:14 INFO - PROCESS | 1652 | __startTimestamp1479840314222__endTimestamp 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:45:14 INFO - PROCESS | 1652 | Number of tests: 14 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 10:45:14 INFO - PROCESS | 1652 | Values: 114.0 114.0 114.0 113.0 113.0 112.0 113.0 114.0 114.0 113.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:140.00 stddev:23.02 (16.4%) stddev-sans-first:20.83 10:45:14 INFO - PROCESS | 1652 | Values: 169.0 140.0 123.0 146.0 114.0 113.0 112.0 117.0 174.0 140.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 10:45:14 INFO - PROCESS | 1652 | Values: 184.0 183.0 184.0 185.0 187.0 181.0 185.0 185.0 183.0 185.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:74.20 Median:72.00 stddev:17.47 (24.3%) stddev-sans-first:18.44 10:45:14 INFO - PROCESS | 1652 | Values: 79.0 65.0 81.0 111.0 89.0 59.0 60.0 58.0 82.0 58.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:11.34 (14.2%) stddev-sans-first:11.41 10:45:14 INFO - PROCESS | 1652 | Values: 88.0 70.0 94.0 72.0 67.0 68.0 89.0 68.0 70.0 92.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 10:45:14 INFO - PROCESS | 1652 | Values: 88.0 85.0 87.0 86.0 88.0 84.0 88.0 85.0 88.0 85.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:94.00 stddev:9.64 (10.3%) stddev-sans-first:10.15 10:45:14 INFO - PROCESS | 1652 | Values: 94.0 94.0 93.0 94.0 101.0 124.0 93.0 94.0 93.0 94.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:82.80 Median:83.50 stddev:1.81 (2.2%) stddev-sans-first:1.92 10:45:14 INFO - PROCESS | 1652 | Values: 83.0 80.0 81.0 86.0 81.0 82.0 84.0 83.0 84.0 84.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 10:45:14 INFO - PROCESS | 1652 | Values: 57.0 55.0 56.0 55.0 57.0 55.0 56.0 57.0 58.0 57.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:72.50 stddev:3.47 (4.8%) stddev-sans-first:2.70 10:45:14 INFO - PROCESS | 1652 | Values: 64.0 74.0 75.0 74.0 73.0 68.0 69.0 69.0 69.0 72.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 10:45:14 INFO - PROCESS | 1652 | Values: 84.0 81.0 83.0 84.0 84.0 84.0 82.0 84.0 85.0 85.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:157.00 stddev:14.35 (9.1%) stddev-sans-first:14.82 10:45:14 INFO - PROCESS | 1652 | Values: 146.0 154.0 135.0 156.0 142.0 157.0 157.0 157.0 189.0 161.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:166.50 stddev:21.57 (13.0%) stddev-sans-first:22.31 10:45:14 INFO - PROCESS | 1652 | Values: 164.0 166.0 166.0 167.0 215.0 159.0 209.0 201.0 165.0 164.0 10:45:14 INFO - PROCESS | 1652 | 10:45:14 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 10:45:14 INFO - PROCESS | 1652 | Values: 67.0 67.0 67.0 66.0 65.0 65.0 65.0 64.0 65.0 65.0 10:45:14 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:45:14 INFO - PROCESS | 1652 | 10:45:15 INFO - TEST-INFO | 1652: exit 0 10:45:15 INFO - TEST-OK | kraken | took 58892ms 10:45:15 INFO - SUITE-END | took 1177s 10:45:15 INFO - Completed test suite (00:19:37) 10:45:15 INFO - javascript benchmark 10:45:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.8488068036936, 3371.4942758586217, 3381.8478168482416, 3416.5387672664183, 3417.1115509967417, 5679.744411501482, 5712.771489140435, 5752.626079304842, 5756.453136951988, 5775.133729940511, 5673.744681489333, 5752.712364381785, 5765.6828874411995, 5767.423257674231, 5771.394003629611, 5190.2474141249595, 5216.452272511388, 5218.582513398938, 5233.947660523403, 5267.078261304257, 5165.586753059746, 5179.715115668637, 5307.363116426034, 5311.097113490697, 5312.256284120207, 5171.250168725533, 5196.896062078757, 5205.16717325228, 5235.633505654606, 5248.239005344223, 5230.372355317368, 5249.291345668324, 5251.186066159713, 5292.894142117136, 5298.09932311508, 5229.189475631245, 5230.607704422146, 5263.499967503081, 5278.498542638443, 5310.60170487215, 5623.297087864017, 5624.353199382042, 5663.915041274384, 5666.603337766358, 5681.204631351573, 6174.629522228635, 6201.689915504252, 6226.470749986257, 6237.844053898643, 6251.281102673205, 6219.906701399483, 6260.843478913018, 6291.7168727406915, 6299.5905266158015, 6302.306746257908, 5717.971410142923, 5762.423757624204, 5826.679532625746, 5848.853778655568, 5871.295444546682, 6238.812835614939, 6256.249250090018, 6271.811845644638, 6282.465990390777, 6286.245650521875, 6187.319394866561, 6193.597416168025, 6194.690265486708, 6198.907016394758, 6211.937880621136, 6154.969225153845, 6210.813675589739, 6238.625682459067, 6252.093446450239, 6276.184096067482, 6203.565750397429, 6244.812655620339, 6281.7173227204885, 6286.245650521967, 6306.65313407767, 6243.968780156161, 6255.655938923403, 6276.246850377893, 6290.842728931813, 6314.400131987454, 4097.323941549671, 4848.684835485682, 4863.489333619989, 4970.229614409773, 4976.253561965734, 4459.910801783946, 4474.619657329164, 4485.439320084989, 4496.572825581565, 4506.6169375602785, 5745.339285982082, 5767.394423585547, 5767.769289228384, 5782.277215348082, 5784.739686714108, 6217.875642487215, 6219.968900155471, 6233.625982441068, 6243.032329988859, 6287.622742635456, 5859.091840764689, 5863.501602363762, 5880.941190588125, 5893.0, 5894.263217097863, 5454.563634909197, 5462.3445186577865, 5462.672239665632, 5468.453154684579, 5479.068558345091, 6162.661053642003, 6212.658303793335, 6215.223097112861, 6220.471259942956, 6312.684365781693, 6277.058441233851, 6281.309056003744, 6289.874202515833, 6301.464375528131, 6315.273743519554, 6316.115743795965, 6322.557420980487, 6328.430441260124, 6330.588511746721, 6334.113224148531, 6104.938950610437, 6131.835460087213, 6139.938600613937, 6246.3753624637175, 6281.309056003927, 6207.534434917489, 6279.843003924939, 6308.274548426806, 6331.176946996861, 6334.746610135543, 6175.814725558241, 6176.66028368444, 6177.907331390123, 6185.010398336244, 6208.937910620836, 5891.970540147443, 5982.760689572368, 6043.2748070231855, 6148.538859585459, 6155.2921414037955, 5868.882622347614, 5913.29040515141, 5918.496927761188, 5972.134040564007, 5991.041433370639, 5061.493850614909, 6078.696065196811, 6093.664848433379, 6100.115483254992, 6122.418370254819, 5771.3651498335985, 5794.594378393641, 5927.525797936241, 5958.374370691188, 5960.314563825215], "value": 5719.627934075426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.94653114891787, 494.8441241009082, 520.6979951628056, 527.2328761651795, 547.7019463870628, 29194.854025729866, 38179.0, 39293.41059884097, 39418.80290598543, 41117.794411027906, 39780.00549986252, 39996.40005399921, 40477.79761101198, 40532.59467405325, 40614.59385406145, 9115.316351273648, 9294.349395542315, 9295.628174872996, 9299.767505812375, 9301.162895339452, 8435.987681478231, 8812.691555795549, 9194.172524472797, 9297.209737172348, 9305.534723263843, 9270.0, 9318.347715659873, 9323.114304141096, 9343.159115679588, 9399.906000940005, 8582.570871456433, 8622.267107295856, 9146.222571081466, 9307.255419566418, 9312.301577381724, 9171.449713017173, 9255.074492550759, 9262.16640502358, 9263.675771347971, 9265.980742118361, 38422.80788596067, 38700.0, 38746.80626596849, 38783.836484905216, 38952.80523597364, 3288.4574045282498, 3445.586529616437, 3517.4899639552377, 3556.893293201182, 3655.5796083450477, 24544.509109817704, 25693.48613027729, 30153.396932061456, 30329.69670303313, 30715.69284307173, 3198.648148703664, 3217.871285148591, 3244.5619841321354, 3245.6592057833823, 3246.5130230465384, 493020.0, 502819.0, 503981.0, 504463.0, 516338.0, 62986.0, 64533.35466645368, 64543.67728161423, 64588.0, 64625.38436539124, 32657.836710816293, 35950.92147235587, 36176.0, 63626.68186659037, 68767.96848047283, 16189.190540473164, 16567.17164141788, 16593.41923032688, 16600.750988735177, 16631.417900373428, 12563.560275390317, 12654.746905062031, 12659.556915508098, 12668.619941401772, 12677.302748348744, 19714.70427943582, 19817.900910495642, 19993.800061999194, 20043.298484553263, 20056.0, 8069.757907262791, 8152.084260198849, 8152.592370381457, 8163.0612479564425, 8231.547264900488, 835.6532039203662, 911.6353458616474, 927.4852456886358, 963.7157038673608, 1085.5766251162054, 27763.583546246824, 28229.0, 28790.71209287922, 29006.709932900823, 29119.0, 678.5352033856824, 1020.5713600287897, 1064.627380416848, 1089.716673664837, 1132.773445310941, 14496.637584060483, 14928.40286388554, 15005.624859378384, 15350.232488375537, 15376.538703838904, 704315.9568404353, 714244.0, 715328.0, 716498.0, 720050.0, 55009.449905500434, 55549.44450555443, 55588.0, 55672.44327556673, 55697.443025570035, 1206.4329765010432, 1244.875512448748, 1360.9455621775217, 1430.9983011891718, 1538.7307221236463, 28796.280092997844, 30366.089017329516, 30436.086917392513, 30556.541651875683, 31086.184962800493, 47456.288155677, 48500.0, 48513.757431212616, 48535.271970919755, 48547.02905941932, 621783.0, 632331.0, 634000.0, 635220.0, 637968.0, 40237.798811005756, 41018.38472422856, 41271.1745765077, 42461.78769106135, 43174.136517270104, 41503.96240094022, 44794.0, 44937.0, 45195.774021129684, 45733.0, 36756.44865326969, 36964.07589810276, 37167.814160929025, 37501.74070463737, 38343.808280959536, 36894.077648059014, 37257.813710931274, 38161.42757858579, 38178.0, 38205.23589528138, 36077.81961090178, 36352.81823590971, 36738.71414500479, 37154.25691486101, 37483.625163748016, 31505.527417088302, 32660.693572256845, 33126.668733312355, 33145.33709325848, 33269.50095748517, 24140.0, 24609.876950615133, 24675.8766206175, 24856.502869942862, 25329.74670253274], "value": 19828.443924636107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.82662495377275, 367.963203679632, 369.95930447650755, 383.6642937429749, 402.9113595009099, 14690.926545367272, 15169.924150379247, 20215.787052776825, 20594.691079633816, 21389.67915481269, 19905.104270307835, 20076.69884951727, 20149.697754533656, 20655.380338589865, 20848.791512084874, 5713.17159011943, 5912.822615321547, 5966.79116230932, 5967.134765459005, 5977.43214394634, 5151.175811870102, 5183.50756678115, 5564.527015203713, 5914.9408505915035, 6040.96979515104, 5842.766289348421, 5953.70231488426, 5956.791512297071, 5963.55273354498, 5970.432808883149, 5739.913901291463, 5935.584509084366, 5960.79137230197, 5986.341502434729, 5990.371011043821, 5159.664621799571, 5347.358317001946, 5694.886102277931, 5784.566157538159, 5788.334341550733, 23512.412189695224, 24543.754562454327, 24689.876550617133, 25077.749222507722, 25673.101441449646, 2129.9148034078617, 2161.070739581979, 2222.376691856237, 2386.7613238675995, 2586.4180559374176, 9326.253899688008, 10422.478876056166, 10804.1896857736, 11358.94320528392, 15871.841281587152, 1747.6679430908086, 1806.2413786209822, 1875.3623767918973, 1886.9245230190777, 1926.6917293233016, 106022.0, 125581.37209313986, 127306.53171403479, 132288.0, 133882.0, 11316.26444281119, 11577.131715121399, 11768.470418831173, 11838.526458941546, 12189.51241950312, 12860.292683902288, 13504.86495135036, 13657.521986730417, 13680.794788078187, 14380.496682616058, 8388.454750441202, 8468.110848360957, 8470.237678608955, 8572.399932004824, 8587.313014958789, 8332.208440198292, 8360.958195208985, 8378.790530236793, 8530.914690853137, 8531.402801803939, 4460.018795864905, 4550.863474095782, 4555.2711566149255, 4624.884377890579, 4645.0477652081245, 1652.5290292266645, 1862.5565186979927, 1916.9233230670895, 1935.7289979402894, 1946.7274581558593, 766.8504641594947, 873.7466134820958, 907.8865141857268, 941.0, 1014.2798612984864, 20366.490837728878, 21277.78722212758, 21431.357059288246, 21471.03380347888, 21602.135914563554, 744.7207297263526, 926.4533924984291, 929.5677509957902, 942.8632848236967, 948.0186410402155, 10598.788024239471, 11234.213605047567, 11245.493952772145, 11248.887511124783, 11253.887461125283, 518875.0, 575416.0, 582637.0, 590111.0, 592303.0, 125328.0, 131265.0, 131973.0, 134420.0, 134851.0, 950.102153464969, 958.8274110660149, 971.4705485510414, 974.1622204903778, 976.3556053004983, 17892.46322610324, 18516.259349625863, 18903.716444253623, 18958.715619265447, 19007.619847603248, 36713.44929826108, 48470.54588362355, 50001.74999124981, 51142.48857511377, 52533.0, 70426.64786676034, 70473.64763176152, 71934.28065719276, 72068.63965680137, 72118.63940680263, 7782.684276779809, 7996.41550294965, 8344.916550834414, 8438.071812100541, 8596.656133754579, 10615.469226538797, 12407.75184496287, 12966.0, 13116.278604676834, 13434.865651343362, 10906.61826836057, 11274.210805243554, 11307.265027773168, 11327.603533876274, 11559.190856639954, 10743.462826858782, 10922.399268040333, 11005.779884402427, 11197.0, 11326.716832079264, 10595.470226488798, 11270.887291126985, 11333.546658133582, 11595.304281743123, 11653.941730291293, 8079.434439589172, 8091.352691784761, 8202.548859812767, 8278.917210828056, 8506.61720222579, 8154.75535733929, 10546.683599492027, 10911.0, 11173.720656983316, 11239.719007024889], "value": 9481.24627995362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.960731178065, 1481.7925490431342, 1506.9397224111035, 1657.0, 1817.2004318100035, 7490.475666703326, 7900.367970562348, 7901.091374491935, 7915.960420197898, 7917.960410197956, 7720.845583088335, 8201.466904651208, 8404.411691181604, 8423.95788021059, 8553.230209281164, 2325.883705814711, 2353.9411514712097, 2356.234223877238, 2357.6227803551437, 2362.090595120874, 2326.174208156097, 2373.905043798246, 2379.4527258730504, 2380.9166679166233, 2385.2128797496785, 2313.3406979010983, 2318.733345665245, 2342.894569744357, 2349.565330413879, 2356.9410764730846, 2295.0, 2300.1489448903844, 2330.5571941331177, 2332.8250381221305, 2341.4848733278823, 2340.1926335414255, 2364.397078744909, 2365.929022129339, 2366.514864452783, 2375.5130198309307, 8447.32421406286, 8501.149885011511, 8555.443896146793, 8573.0, 8586.484810911365, 4644.698094623838, 4742.549457801503, 5249.317588713481, 5255.816046438356, 5261.684298942076, 3253.869845206189, 3468.5490886184634, 3654.6710796028483, 3659.5608526976935, 3660.3045421369857, 1053.6891616972935, 1076.6339444588798, 1102.366139469808, 1116.6426743442103, 1118.6028959719263, 11078.501467433985, 11290.26613270143, 11295.0, 11310.37792921389, 11312.66062018149, 4362.0, 4433.866983990485, 4517.277235642281, 4774.522547745198, 4783.641226907996, 9749.415035097916, 9754.219662426989, 9755.122039016522, 9760.121589057018, 9806.558704858298, 5262.447443018505, 5293.735313234323, 5296.285001524822, 5304.522592966651, 5307.363116426053, 4617.976910115495, 4719.5752382285755, 4753.025629745894, 4829.492903245179, 4838.056578967067, 3678.4850120983083, 3706.425504046877, 3779.1874746929543, 3817.141143242748, 3848.9230215395537, 1189.5241903238773, 1221.9205751626293, 1222.4865556466304, 1235.9011279097651, 1245.6014075495937, 860.2043110123111, 868.5700578213698, 891.888513935758, 899.0470101692097, 912.2337236721186, 5451.972740136274, 5469.097598896217, 5565.1374037024325, 5716.599028408079, 5823.359430462646, 441.14858323435436, 449.0905915521096, 449.6200710399707, 462.77555385637936, 462.85651448051215, 3663.46879702447, 3780.7353485256317, 3820.178661587772, 3828.349180639298, 3845.307844587945, 8029.959850200712, 9231.584578693975, 9645.37305075168, 10390.636327728493, 10393.168546516412, 7696.191899850435, 9654.27592930533, 9732.172765314886, 10066.597336106473, 10232.23258255619, 7657.885131723028, 7736.961315193501, 7788.532688038736, 7790.220977902278, 7941.285284324323, 5677.8864422710485, 5706.657600543981, 5714.342850572238, 5733.483986441241, 5761.711914404179, 9149.405288656217, 9395.0, 9467.905320946978, 9580.856287155559, 9616.471094089893, 9549.188318992685, 9583.712488625353, 9676.70969870905, 9762.658306959222, 9848.950755246178, 6998.405135563534, 7101.680424380812, 7151.141862976268, 7170.498065135391, 7301.306375894282, 7861.52830830152, 8027.919720802951, 8032.959835200787, 8034.995625546807, 8035.959820200862, 7150.7497237596435, 7268.600226987355, 7286.599237042014, 7320.487565870338, 7406.481546291708, 7099.467539934629, 7128.581276439529, 7135.108111486064, 7166.605836679033, 7200.279972002758, 5704.686242256716, 6687.0, 6727.899081513683, 6750.696218670073, 6824.351686589766, 4869.050535145612, 4888.608911287018, 4915.705057696549, 4960.677555958851, 4999.10016197088, 4217.91564168721, 4804.759762011955, 4871.464138944784, 4914.311996320589, 4996.3005179274205], "value": 4353.606487350771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.48481385938035, 262.9815912886098, 302.4933236828313, 308.60806775395247, 314.6381661089748, 4906.528041587528, 5106.7446627668605, 5108.667936584119, 5179.559737422319, 5206.29714988476, 4447.866564003077, 4629.7222166669935, 4939.332760309438, 5036.0, 5048.066107770056, 3490.7207423406194, 3531.0452293431395, 3886.5919078496777, 3899.401245489357, 3902.8829135125848, 3612.1644509060393, 3819.2934307153128, 3918.157596116834, 3929.960700392988, 3950.7629542227414, 3832.310184166849, 3874.9850077959445, 3880.5149356330458, 3906.277338692351, 3921.4117882317596, 3364.2598628301735, 3801.9434152577005, 3864.516935383091, 3865.5747867734526, 3893.0, 3449.741269404805, 3451.4132597458492, 3453.6028356739043, 3454.5336379588935, 3456.7753096048677, 4118.537919038728, 4333.71830830995, 4903.583195428393, 4924.75376231187, 4942.431620363668, 3892.7811147645853, 4390.956090439086, 4469.262571675669, 4487.259602165639, 4487.326900964848, 4029.8589549365634, 4493.932591011137, 5051.722155281458, 5352.598555108382, 5388.272583201296, 3196.488561830096, 3489.2672538766888, 3518.7712798668003, 3813.694904407641, 3829.0, 5547.389787123454, 5547.696291371524, 5554.444555544454, 5564.33228012641, 5586.41342659019, 3233.8196558256536, 3354.859347821752, 3699.445083237482, 3847.788371639587, 3856.7107466940092, 3315.5192497087787, 3531.788092714445, 3781.6029316921877, 3939.4484772131923, 3949.940750888739, 3949.822257998397, 4042.0501182222743, 4303.794937417466, 4333.393324934512, 4523.185826551186, 4465.709728867613, 5342.572594192456, 5352.892942141136, 5353.411124776271, 5375.220593013991, 1151.7696460707891, 1184.461070213051, 1207.710149564116, 1223.9877601224052, 1245.1221888568537, 861.401326078382, 878.4290211362666, 881.0308660473556, 886.9379143460025, 886.9600867960958, 4145.2124096422185, 4590.816367345269, 4751.099560175957, 4766.499517550607, 4781.713097214179, 4403.4495688039, 5028.622853285945, 5041.909334172779, 5191.9480805192225, 5223.13818219997, 4435.4233949587, 4605.815767369335, 4626.357643036674, 4666.789994450258, 4697.553732395417, 2394.521095780851, 2657.0036236411347, 2675.2375572961614, 2685.2883985743792, 2705.837649741022, 4566.511251367946, 4793.23308270675, 5297.655652382583, 5325.4674532547215, 5341.596281673263, 4634.443866736014, 5277.894442111213, 5283.833628212491, 5285.445028271976, 5310.628256022119, 4611.371518234574, 4684.844971313234, 4941.876453088629, 5315.468453154808, 5325.840224793263, 4204.393276168673, 4383.189110014658, 4561.471906911222, 4625.653076019379, 4947.851564453073, 5050.469700681376, 5079.917233934217, 5080.872978175576, 5101.668391554537, 5118.769655365592, 4125.443065186161, 4265.808038638331, 5200.959808038332, 5209.010288045411, 5259.396598683676, 2985.447692176954, 3406.846691898821, 3575.0863046616923, 3637.2907283079544, 3641.344557979589, 4443.178012067778, 4582.656300777388, 4705.564802735199, 4980.750962451791, 5140.665856719302, 4703.576678098988, 4979.626528010342, 5000.974605284866, 5012.122878496321, 5019.749012549285, 4620.468646105606, 4768.38011058574, 4973.538098641196, 4975.452700203047, 4981.37732783402, 4253.8723838284905, 4583.427071616048, 4776.402949631296, 4952.5542701157065, 5115.411727651368, 4258.615175501729, 4716.221823399101, 4745.928811067905, 5324.574034077187, 5350.652207606493, 4452.755098469615, 5204.843854684365, 5219.556337711337, 5225.92161117576, 5303.196913049582], "value": 3772.9564944879, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.555145846449, 659.4394764450218, 691.2568988337537, 706.604301591109, 763.1071646173974, 13931.37308821103, 14594.927025364885, 14653.853461465382, 14654.19401932892, 14736.410543578271, 12857.807132892991, 12932.870671293284, 12956.0, 12970.286634235114, 12973.870261297385, 638.7061951502315, 664.060354598243, 664.3356643356643, 814.0597609760736, 833.1959658929133, 797.9401544884128, 807.446898874273, 819.5820131732829, 822.6215940667271, 825.63671984327, 873.388627960427, 876.7851876290285, 877.5392918717693, 880.7093659092516, 881.2949640287776, 687.9312068793131, 712.2094475132599, 872.3195907192337, 872.3370238618633, 872.9301655867515, 627.8555932135589, 645.096864389858, 645.4223469994375, 646.647577070493, 649.4447247603325, 13490.190588564717, 13840.93079534596, 13874.236916969563, 13914.721705565933, 13925.791113133311, 12423.3788310585, 12652.873471265262, 12743.553975610901, 12767.361631918367, 12817.87182128176, 9946.154576860976, 10067.89932100677, 10434.791304173874, 12018.39908004605, 12059.155859089868, 4373.934390984138, 4411.228035093878, 4412.977935110304, 4479.10417916418, 4570.794314255866, 92317.5384123075, 93063.60404593937, 93384.53307733418, 94688.0, 95299.0, 9634.518274086267, 10091.243156763272, 10246.231532634933, 10255.794884102275, 10520.789584208273, 19251.903740481488, 19985.0, 20081.698774518394, 20141.0, 20475.0, 7523.322900938832, 7677.0, 7699.961500192575, 7742.458027937991, 7787.143414224431, 4179.707420480538, 4227.830886764556, 4248.596383343577, 4430.379746835446, 4478.2386994211065, 3429.1255729788745, 3544.9822750886597, 3546.769459985093, 3549.893503194908, 3556.6621170988715, 652.1456891472187, 658.9242237142694, 664.7407511070686, 674.7368526274756, 677.7153595489906, 600.3906035374099, 660.1352228580574, 665.5376296164203, 671.1476424940298, 695.4575431163701, 8750.124987501198, 8865.734027979172, 8908.777280567909, 9259.814803704023, 9463.668771592962, 639.8144538083997, 652.6051738698114, 665.9640893955346, 667.68952437116, 677.7864972533735, 4246.617804397619, 4466.441694788152, 4514.6388288936805, 4522.547745225517, 4580.1984652686315, 97236.51381743046, 122582.0, 123870.0, 124997.37501312436, 125972.0, 78951.0, 100927.49536252272, 102270.48864755778, 108124.4593777026, 110416.0, 92672.82972266265, 94564.0, 96542.0, 97337.0, 97607.51196244116, 8844.911550884666, 8854.24738897201, 8884.0, 8884.911150888409, 8916.68791592317, 60505.69747151236, 60982.69508652428, 61325.693371532856, 62102.68948655228, 63695.0, 65951.0, 88010.67983980374, 88608.67086993829, 89320.10679893378, 90241.0, 10875.945620271848, 11090.889091109308, 11264.94367528157, 11372.43137843121, 11439.42802859837, 12141.878581214074, 12166.513339466323, 12318.630441086782, 12387.07096967713, 12471.064670149593, 11378.08975281992, 11948.223365481215, 11982.041436684869, 12449.883519801475, 12475.0, 11997.280163190237, 12001.099917506397, 12299.69250768738, 12475.376231188222, 12480.875191247971, 11552.59565915189, 11792.997595204504, 11837.940810295893, 12245.632631021084, 12350.876491234972, 9296.629359513281, 9514.762130946781, 10024.890481879496, 10087.04173103554, 10202.571639970261, 9838.06538378853, 10175.185985121025, 10200.4389758564, 10207.89792102099, 10210.795784084425], "value": 7259.999592199374, "unit": "score"}], "name": "dromaeo_css", "value": 7101.337091794876, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 112.0, 113.0, 114.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 140.0, 123.0, 146.0, 114.0, 113.0, 112.0, 117.0, 174.0, 140.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 185.0, 187.0, 181.0, 185.0, 185.0, 183.0, 185.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 65.0, 81.0, 111.0, 89.0, 59.0, 60.0, 58.0, 82.0, 58.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 94.0, 72.0, 67.0, 68.0, 89.0, 68.0, 70.0, 92.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 86.0, 88.0, 84.0, 88.0, 85.0, 88.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 101.0, 124.0, 93.0, 94.0, 93.0, 94.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 86.0, 81.0, 82.0, 84.0, 83.0, 84.0, 84.0], "value": 82.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 55.0, 57.0, 55.0, 56.0, 57.0, 58.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 75.0, 74.0, 73.0, 68.0, 69.0, 69.0, 69.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 84.0, 84.0, 84.0, 82.0, 84.0, 85.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 154.0, 135.0, 156.0, 142.0, 157.0, 157.0, 157.0, 189.0, 161.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 167.0, 215.0, 159.0, 209.0, 201.0, 165.0, 164.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1460.1999999999998, "alertThreshold": 2.0}]} 10:45:15 INFO - Return code: 0 10:45:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:45:15 ERROR - # TBPL SUCCESS # 10:45:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:15 INFO - 2016-11-22 10:45:15.541 screenresolution[1656:9876] starting screenresolution argv=screenresolution get 10:45:15 INFO - 2016-11-22 10:45:15.544 screenresolution[1656:9876] Display 0: 1600x1200x32@60 10:45:15 INFO - 2016-11-22 10:45:15.550 screenresolution[1657:9879] starting screenresolution argv=screenresolution list 10:45:15 INFO - Available Modes on Display 0 10:45:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:15 INFO - Intel Iris: 10:45:15 INFO - Chipset Model: Intel Iris 10:45:15 INFO - Type: GPU 10:45:15 INFO - Bus: Built-In 10:45:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:15 INFO - Vendor: Intel (0x8086) 10:45:15 INFO - Device ID: 0x0a2e 10:45:15 INFO - Revision ID: 0x0009 10:45:15 INFO - Displays: 10:45:15 INFO - Display: 10:45:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:15 INFO - Display Serial Number: 1600x1200 60 10:45:15 INFO - Main Display: Yes 10:45:15 INFO - Mirror: Off 10:45:15 INFO - Online: Yes 10:45:15 INFO - Rotation: Supported 10:45:15 INFO - Return code: 0 10:45:15 INFO - Running post-action listener: _resource_record_post_action 10:45:15 INFO - [mozharness: 2016-11-22 18:45:15.793447Z] Finished run-tests step (success) 10:45:15 INFO - Running post-run listener: _resource_record_post_run 10:45:15 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 650553856; Read time: 233; Write time: 1829 10:45:15 INFO - TinderboxPrint: CPU usage
53.6% 10:45:15 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 233 10:45:15 INFO - TinderboxPrint: I/O write bytes / time
650,553,856 / 1,829 10:45:15 INFO - TinderboxPrint: CPU idle
2,247.2 (46.4%) 10:45:15 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 10:45:15 INFO - TinderboxPrint: CPU user
1,625.5 (33.6%) 10:45:15 INFO - TinderboxPrint: Swap in / out
390,639,616 / 0 10:45:15 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 350654976; Write bytes: 346200064; Read time: 27481; Write time: 706 10:45:15 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35042304; Write bytes: 293364224; Read time: 210; Write time: 1090 10:45:16 INFO - Running post-run listener: _upload_blobber_files 10:45:16 INFO - Blob upload gear active. 10:45:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:45:16 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:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:45:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:18 INFO - (blobuploader) - INFO - Done attempting. 10:45:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:45:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:45:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:19 INFO - (blobuploader) - INFO - Done attempting. 10:45:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:45:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:21 INFO - (blobuploader) - INFO - Done attempting. 10:45:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:45:21 INFO - Return code: 0 10:45:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:45:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:45:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12b7879c1c976a306179ab314fab3607179fdb8ec77c9967164360fef0cc756bf34ea0bec401b288a4c64578e73b9638bc4f751afa51e0abe71d2103b3cb492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cba58c1c781c79dac2f3d1398e1204f6a1f37ebbdf97f8bc3e9c8b2ff26666ee84f664300890a955a8aedfc74ec573f8f60a95262255450b13fa13974c6c0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8dc8a3d4acbaeed36ca80118d68ac2d0a629713867734c2f3b4a41e631b47123e3de3421c8523e53fd26363a6f55b41ad4d825012bda5abdab84c5f233bd51"} 10:45:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:45:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:45:21 INFO - Contents: 10:45:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12b7879c1c976a306179ab314fab3607179fdb8ec77c9967164360fef0cc756bf34ea0bec401b288a4c64578e73b9638bc4f751afa51e0abe71d2103b3cb492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cba58c1c781c79dac2f3d1398e1204f6a1f37ebbdf97f8bc3e9c8b2ff26666ee84f664300890a955a8aedfc74ec573f8f60a95262255450b13fa13974c6c0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8dc8a3d4acbaeed36ca80118d68ac2d0a629713867734c2f3b4a41e631b47123e3de3421c8523e53fd26363a6f55b41ad4d825012bda5abdab84c5f233bd51"} 10:45:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:45:21 INFO - Copying logs to upload dir... 10:45:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:45:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.652505 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-22 10:45:21.894951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:45:21.899281) ========= 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.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12b7879c1c976a306179ab314fab3607179fdb8ec77c9967164360fef0cc756bf34ea0bec401b288a4c64578e73b9638bc4f751afa51e0abe71d2103b3cb492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cba58c1c781c79dac2f3d1398e1204f6a1f37ebbdf97f8bc3e9c8b2ff26666ee84f664300890a955a8aedfc74ec573f8f60a95262255450b13fa13974c6c0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8dc8a3d4acbaeed36ca80118d68ac2d0a629713867734c2f3b4a41e631b47123e3de3421c8523e53fd26363a6f55b41ad4d825012bda5abdab84c5f233bd51"} build_url:https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010907 build_url: 'https://queue.taskcluster.net/v1/task/LnXgCjLjR2GiqwaXfkUglQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12b7879c1c976a306179ab314fab3607179fdb8ec77c9967164360fef0cc756bf34ea0bec401b288a4c64578e73b9638bc4f751afa51e0abe71d2103b3cb492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cba58c1c781c79dac2f3d1398e1204f6a1f37ebbdf97f8bc3e9c8b2ff26666ee84f664300890a955a8aedfc74ec573f8f60a95262255450b13fa13974c6c0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8dc8a3d4acbaeed36ca80118d68ac2d0a629713867734c2f3b4a41e631b47123e3de3421c8523e53fd26363a6f55b41ad4d825012bda5abdab84c5f233bd51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 10:45:21.933397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:45:21.933719) ========= 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.iQmRCubdSM/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.C30EEM4q1T/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.004946 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 10:45:21.982119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:45:21.982451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 10:45:21.982766) ========= ========= Total master_lag: 0.18 =========