builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0155 starttime: 1479152663.13 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.134091) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.134573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.134852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.160313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.160724) ========= 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.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-14 11:44:23-- 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% 151M=0s 2016-11-14 11:44:23 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.257547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.257865) ========= 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.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.027393 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:23.306458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:44:23.306826) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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 f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-14 11:44:23,388 truncating revision to first 12 chars 2016-11-14 11:44:23,388 Setting DEBUG logging. 2016-11-14 11:44:23,388 attempt 1/10 2016-11-14 11:44:23,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:44:24,571 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:44:24.759277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:24.759607) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:24.759982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:24.760242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:24.778813) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-14 11:44:24.779106) ========= /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.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:44:24 INFO - MultiFileLogger online at 20161114 11:44:24 in /builds/slave/test 11:44:24 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 11:44:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:24 INFO - {'append_to_log': False, 11:44:24 INFO - 'base_work_dir': '/builds/slave/test', 11:44:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:44:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:24 INFO - 'branch': 'Mozilla-Aurora', 11:44:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:24 INFO - 'config_files': ('talos/mac_config.py',), 11:44:24 INFO - 'default_actions': ('clobber', 11:44:24 INFO - 'read-buildbot-config', 11:44:24 INFO - 'download-and-extract', 11:44:24 INFO - 'populate-webroot', 11:44:24 INFO - 'create-virtualenv', 11:44:24 INFO - 'install', 11:44:24 INFO - 'run-tests'), 11:44:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:24 INFO - 'download_minidump_stackwalk': True, 11:44:24 INFO - 'download_symbols': 'ondemand', 11:44:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:24 INFO - 'installer_path': 'installer.exe', 11:44:24 INFO - 'log_level': 'info', 11:44:24 INFO - 'log_name': 'talos', 11:44:24 INFO - 'log_to_console': True, 11:44:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:44:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:44:24 INFO - 'opt_config_files': (), 11:44:24 INFO - 'pip_index': False, 11:44:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:24 INFO - 'cmd': ('bash', 11:44:24 INFO - '-c', 11:44:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:24 INFO - 'enabled': True, 11:44:24 INFO - 'halt_on_failure': False, 11:44:24 INFO - 'name': 'check_screen_resolution'},), 11:44:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:24 INFO - 'cmd': ('bash', 11:44:24 INFO - '-c', 11:44:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:24 INFO - 'enabled': True, 11:44:24 INFO - 'halt_on_failure': False, 11:44:24 INFO - 'name': 'check_screen_resolution'},), 11:44:24 INFO - 'run_cmd_checks_enabled': True, 11:44:24 INFO - 'sps_profile': False, 11:44:24 INFO - 'sps_profile_interval': 0, 11:44:24 INFO - 'suite': 'dromaeojs', 11:44:24 INFO - 'system_bits': '32', 11:44:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:24 INFO - 'title': 't-yosemite-r7-0155', 11:44:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:24 INFO - 'use_talos_json': True, 11:44:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:24 INFO - 'work_dir': 'build'} 11:44:24 INFO - [mozharness: 2016-11-14 19:44:24.991361Z] Running clobber step. 11:44:24 INFO - Running pre-action listener: _resource_record_pre_action 11:44:24 INFO - Running main action method: clobber 11:44:24 INFO - rmtree: /builds/slave/test/build 11:44:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:27 INFO - Running post-action listener: _resource_record_post_action 11:44:27 INFO - [mozharness: 2016-11-14 19:44:27.287712Z] Finished clobber step (success) 11:44:27 INFO - [mozharness: 2016-11-14 19:44:27.287946Z] Running read-buildbot-config step. 11:44:27 INFO - Running pre-action listener: _resource_record_pre_action 11:44:27 INFO - Running main action method: read_buildbot_config 11:44:27 INFO - Using buildbot properties: 11:44:27 INFO - { 11:44:27 INFO - "project": "", 11:44:27 INFO - "product": "firefox", 11:44:27 INFO - "script_repo_revision": "production", 11:44:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:44:27 INFO - "repository": "", 11:44:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:44:27 INFO - "buildid": "20161114081542", 11:44:27 INFO - "pgo_build": "False", 11:44:27 INFO - "basedir": "/builds/slave/test", 11:44:27 INFO - "buildnumber": 38, 11:44:27 INFO - "slavename": "t-yosemite-r7-0155", 11:44:27 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:44:27 INFO - "platform": "yosemite_r7", 11:44:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:44:27 INFO - "branch": "mozilla-aurora", 11:44:27 INFO - "repo_path": "releases/mozilla-aurora", 11:44:27 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:44:27 INFO - "stage_platform": "macosx64", 11:44:27 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:44:27 INFO - "slavebuilddir": "test" 11:44:27 INFO - } 11:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 11:44:27 INFO - Running post-action listener: _resource_record_post_action 11:44:27 INFO - [mozharness: 2016-11-14 19:44:27.293693Z] Finished read-buildbot-config step (success) 11:44:27 INFO - [mozharness: 2016-11-14 19:44:27.293901Z] Running download-and-extract step. 11:44:27 INFO - Running pre-action listener: _resource_record_pre_action 11:44:27 INFO - Running main action method: download_and_extract 11:44:27 INFO - mkdir: /builds/slave/test/build/tests 11:44:27 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')]} 11:44:27 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 11:44:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/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 11:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/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 11:44:28 INFO - Downloaded 1199 bytes. 11:44:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:44:28 INFO - Using the following test package requirements: 11:44:28 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:44:28 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 11:44:28 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 11:44:28 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'jsshell-mac.zip'], 11:44:28 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 11:44:28 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:44:28 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 11:44:28 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 11:44:28 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 11:44:28 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:28 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 11:44:28 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:44:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:44:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:28 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:44:29 INFO - Http code: 200 11:44:29 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 11:44:29 INFO - x-amz-cf-id: yrr1z8bkLZDA05wWwsJEGjJOsfSan-T7v35v6jEWAFwnaHsLDT_jsw== 11:44:29 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:44:29 INFO - Expected file size: 16327504 11:44:29 INFO - Obtained file size: 16327504 11:44:36 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 11:44:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:44:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:36 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:44:37 INFO - Http code: 200 11:44:37 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 11:44:37 INFO - x-amz-cf-id: 0WF4pz2n9w7t46wDwSXckqzUlF4cLJATmRfULRYu5kQWZjgjRMsgHg== 11:44:37 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:44:37 INFO - Expected file size: 16327504 11:44:37 INFO - Obtained file size: 16327504 11:44:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 11:44:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:44:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 11:44:44 INFO - Http code: 200 11:44:44 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 11:44:44 INFO - x-amz-cf-id: M0tXwg7h4JQ47mEBM70lMoAvoNLyI0low1hIVyISl3C44l8qH9tT5Q== 11:44:44 INFO - x-amz-version-id: fL.n5SYgNX8ZLi3RUYlMNYmEt036hZfV 11:44:44 INFO - Expected file size: 14409038 11:44:44 INFO - Obtained file size: 14409038 11:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:45 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:44:45 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 11:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/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 11:44:48 INFO - Downloaded 114359577 bytes. 11:44:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:44:48 INFO - mkdir: /builds/slave/test/properties 11:44:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:48 INFO - Contents: 11:44:48 INFO - build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:44:48 INFO - Running post-action listener: _resource_record_post_action 11:44:48 INFO - Running post-action listener: set_extra_try_arguments 11:44:48 INFO - [mozharness: 2016-11-14 19:44:48.882887Z] Finished download-and-extract step (success) 11:44:48 INFO - [mozharness: 2016-11-14 19:44:48.883007Z] Running populate-webroot step. 11:44:48 INFO - Running pre-action listener: _resource_record_pre_action 11:44:48 INFO - Running main action method: populate_webroot 11:44:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:48 INFO - '--tppagecycles', 11:44:48 INFO - '7'], 11:44:48 INFO - 'tests': ['tsvgm']}}, 11:44:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:44:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['damp', 'tps']}, 11:44:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'tests': ['damp', 'tps']}, 11:44:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['dromaeo_dom']}, 11:44:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['basic_compositor_video']}, 11:44:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:44:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['a11yr', 11:44:48 INFO - 'ts_paint', 11:44:48 INFO - 'tpaint', 11:44:48 INFO - 'sessionrestore', 11:44:48 INFO - 'sessionrestore_no_auto_restore', 11:44:48 INFO - 'tabpaint']}, 11:44:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['tsvgx', 11:44:48 INFO - 'tsvgr_opacity', 11:44:48 INFO - 'tart', 11:44:48 INFO - 'tscrollx', 11:44:48 INFO - 'cart']}, 11:44:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:48 INFO - 'tsvgr_opacity', 11:44:48 INFO - 'tart', 11:44:48 INFO - 'tscrollx', 11:44:48 INFO - 'cart']}, 11:44:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'talos_options': ['--disable-e10s'], 11:44:48 INFO - 'tests': ['tp5o']}, 11:44:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'tests': ['tp5o']}, 11:44:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'talos_options': ['--disable-e10s', 11:44:48 INFO - '--xperf_path', 11:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:48 INFO - 'tests': ['tp5n']}, 11:44:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:44:48 INFO - 'talos_options': ['--xperf_path', 11:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:48 INFO - 'tests': ['tp5n']}}, 11:44:48 INFO - 'talos.zip': {'path': '', 11:44:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:48 INFO - Running post-action listener: _resource_record_post_action 11:44:48 INFO - [mozharness: 2016-11-14 19:44:48.901739Z] Finished populate-webroot step (success) 11:44:48 INFO - [mozharness: 2016-11-14 19:44:48.901818Z] Running create-virtualenv step. 11:44:48 INFO - Running pre-action listener: _resource_record_pre_action 11:44:48 INFO - Running main action method: create_virtualenv 11:44:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:48 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 11:44:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:49 INFO - Using real prefix '/tools/python27' 11:44:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:52 INFO - Installing pip.................done. 11:44:52 INFO - Return code: 0 11:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:44:52 INFO - Reading from file tmpfile_stdout 11:44:52 INFO - Output received: 11:44:52 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) 11:44:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:52 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:44:52 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 11:44:52 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 11:44:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:44:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:52 INFO - 'HOME': '/Users/cltbld', 11:44:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:52 INFO - 'LOGNAME': 'cltbld', 11:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:52 INFO - 'MOZ_NO_REMOTE': '1', 11:44:52 INFO - 'NO_EM_RESTART': '1', 11:44:52 INFO - 'PAGER': '/bin/cat', 11:44:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:52 INFO - 'PWD': '/builds/slave/test', 11:44:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:52 INFO - 'SHELL': '/bin/bash', 11:44:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:44:52 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:44:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:52 INFO - 'USER': 'cltbld', 11:44:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:52 INFO - 'XPC_FLAGS': '0x0', 11:44:52 INFO - 'XPC_SERVICE_NAME': '0', 11:44:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 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 11:44:53 INFO - Cleaning up... 11:44:53 INFO - Return code: 0 11:44:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:53 INFO - 'HOME': '/Users/cltbld', 11:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:53 INFO - 'LOGNAME': 'cltbld', 11:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:53 INFO - 'MOZ_NO_REMOTE': '1', 11:44:53 INFO - 'NO_EM_RESTART': '1', 11:44:53 INFO - 'PAGER': '/bin/cat', 11:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:53 INFO - 'PWD': '/builds/slave/test', 11:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:53 INFO - 'SHELL': '/bin/bash', 11:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:44:53 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:53 INFO - 'USER': 'cltbld', 11:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:53 INFO - 'XPC_FLAGS': '0x0', 11:44:53 INFO - 'XPC_SERVICE_NAME': '0', 11:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 INFO - Downloading/unpacking psutil>=3.1.1 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:56 INFO - Installing collected packages: psutil 11:44:56 INFO - Running setup.py install for psutil 11:44:56 INFO - building 'psutil._psutil_osx' extension 11:44:56 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 11:44:57 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 11:44:57 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 11:44:57 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 11:44:57 INFO - building 'psutil._psutil_posix' extension 11:44:57 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 11:44:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:44:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:44:57 INFO - ^ 11:44:57 INFO - 1 warning generated. 11:44:57 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 11:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:57 INFO - Successfully installed psutil 11:44:57 INFO - Cleaning up... 11:44:58 INFO - Return code: 0 11:44:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:44:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:44:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:58 INFO - 'HOME': '/Users/cltbld', 11:44:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:58 INFO - 'LOGNAME': 'cltbld', 11:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:58 INFO - 'MOZ_NO_REMOTE': '1', 11:44:58 INFO - 'NO_EM_RESTART': '1', 11:44:58 INFO - 'PAGER': '/bin/cat', 11:44:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:58 INFO - 'PWD': '/builds/slave/test', 11:44:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:58 INFO - 'SHELL': '/bin/bash', 11:44:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:44:58 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:44:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:58 INFO - 'USER': 'cltbld', 11:44:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:58 INFO - 'XPC_FLAGS': '0x0', 11:44:58 INFO - 'XPC_SERVICE_NAME': '0', 11:44:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:45:00 INFO - Installing collected packages: mozsystemmonitor 11:45:00 INFO - Running setup.py install for mozsystemmonitor 11:45:01 INFO - Successfully installed mozsystemmonitor 11:45:01 INFO - Cleaning up... 11:45:01 INFO - Return code: 0 11:45:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:45:01 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')]} 11:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:01 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')]} 11:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:01 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45:01 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 11:45:01 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 11:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:01 INFO - 'HOME': '/Users/cltbld', 11:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:01 INFO - 'LOGNAME': 'cltbld', 11:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:01 INFO - 'MOZ_NO_REMOTE': '1', 11:45:01 INFO - 'NO_EM_RESTART': '1', 11:45:01 INFO - 'PAGER': '/bin/cat', 11:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:01 INFO - 'PWD': '/builds/slave/test', 11:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:01 INFO - 'SHELL': '/bin/bash', 11:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:01 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:01 INFO - 'USER': 'cltbld', 11:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:01 INFO - 'XPC_FLAGS': '0x0', 11:45:01 INFO - 'XPC_SERVICE_NAME': '0', 11:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:45:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:45:03 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 11:45:03 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 11:45:03 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 11:45:03 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 11:45:03 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 11:45:03 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 11:45:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:45:04 INFO - warning: no files found matching '*.txt' 11:45:04 INFO - no previously-included directories found matching 'build' 11:45:04 INFO - no previously-included directories found matching 'dist' 11:45:04 INFO - no previously-included directories found matching '.git*' 11:45:04 INFO - Installing collected packages: jsonschema, functools32 11:45:04 INFO - Running setup.py install for functools32 11:45:04 INFO - warning: no files found matching '*.txt' 11:45:04 INFO - no previously-included directories found matching 'build' 11:45:04 INFO - no previously-included directories found matching 'dist' 11:45:04 INFO - no previously-included directories found matching '.git*' 11:45:04 INFO - Successfully installed jsonschema functools32 11:45:04 INFO - Cleaning up... 11:45:04 INFO - Return code: 0 11:45:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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')]} 11:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', '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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:45: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 functools32==3.2.3-2 11:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:04 INFO - 'HOME': '/Users/cltbld', 11:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:04 INFO - 'LOGNAME': 'cltbld', 11:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:04 INFO - 'MOZ_NO_REMOTE': '1', 11:45:04 INFO - 'NO_EM_RESTART': '1', 11:45:04 INFO - 'PAGER': '/bin/cat', 11:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:04 INFO - 'PWD': '/builds/slave/test', 11:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:04 INFO - 'SHELL': '/bin/bash', 11:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:04 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:04 INFO - 'USER': 'cltbld', 11:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:04 INFO - 'XPC_FLAGS': '0x0', 11:45:04 INFO - 'XPC_SERVICE_NAME': '0', 11:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:45:04 INFO - Cleaning up... 11:45:04 INFO - Return code: 0 11:45:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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')]} 11:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', '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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:45: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 blobuploader==1.2.4 11:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:04 INFO - 'HOME': '/Users/cltbld', 11:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:04 INFO - 'LOGNAME': 'cltbld', 11:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:04 INFO - 'MOZ_NO_REMOTE': '1', 11:45:04 INFO - 'NO_EM_RESTART': '1', 11:45:04 INFO - 'PAGER': '/bin/cat', 11:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:04 INFO - 'PWD': '/builds/slave/test', 11:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:04 INFO - 'SHELL': '/bin/bash', 11:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:04 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:04 INFO - 'USER': 'cltbld', 11:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:04 INFO - 'XPC_FLAGS': '0x0', 11:45:04 INFO - 'XPC_SERVICE_NAME': '0', 11:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:45:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:45:07 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 11:45:07 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 11:45:07 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 11:45:07 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 11:45:07 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 11:45:07 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 11:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:45:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:45:08 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 11:45:08 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 11:45:08 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 11:45:08 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 11:45:08 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 11:45:08 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 11:45:08 INFO - Downloading docopt-0.6.1.tar.gz 11:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:45:09 INFO - Installing collected packages: blobuploader, requests, docopt 11:45:09 INFO - Running setup.py install for blobuploader 11:45:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:45:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:45:09 INFO - Running setup.py install for requests 11:45:09 INFO - Running setup.py install for docopt 11:45:09 INFO - Successfully installed blobuploader requests docopt 11:45:09 INFO - Cleaning up... 11:45:09 INFO - Return code: 0 11:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:09 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45:09 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 11:45:09 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 11:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:09 INFO - 'HOME': '/Users/cltbld', 11:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:09 INFO - 'LOGNAME': 'cltbld', 11:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:09 INFO - 'MOZ_NO_REMOTE': '1', 11:45:09 INFO - 'NO_EM_RESTART': '1', 11:45:09 INFO - 'PAGER': '/bin/cat', 11:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:09 INFO - 'PWD': '/builds/slave/test', 11:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:09 INFO - 'SHELL': '/bin/bash', 11:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:09 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:09 INFO - 'USER': 'cltbld', 11:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:09 INFO - 'XPC_FLAGS': '0x0', 11:45:09 INFO - 'XPC_SERVICE_NAME': '0', 11:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-pPvq04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9Vrzwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-2de4YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ljFjo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-kCWMQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-JotLI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-VWZC9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EoDbYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:10 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-SJARv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-D6_914-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-TOmqIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EvMiCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-4_m5Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-FrkSrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-xKqvxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-hR_M0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-7GbiQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:45:11 INFO - Running setup.py install for manifestparser 11:45:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:45:12 INFO - Running setup.py install for mozcrash 11:45:12 INFO - Running setup.py install for mozdebug 11:45:12 INFO - Running setup.py install for mozdevice 11:45:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:45:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:45:12 INFO - Running setup.py install for mozfile 11:45:12 INFO - Running setup.py install for mozhttpd 11:45:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:45:12 INFO - Running setup.py install for mozinfo 11:45:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:45:12 INFO - Running setup.py install for mozInstall 11:45:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Running setup.py install for mozleak 11:45:13 INFO - Running setup.py install for mozlog 11:45:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Running setup.py install for moznetwork 11:45:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Running setup.py install for mozprocess 11:45:13 INFO - Running setup.py install for mozprofile 11:45:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:45:13 INFO - Running setup.py install for mozrunner 11:45:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:45:14 INFO - Running setup.py install for mozscreenshot 11:45:14 INFO - Running setup.py install for moztest 11:45:14 INFO - Running setup.py install for mozversion 11:45:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:45:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:45:14 INFO - Cleaning up... 11:45:14 INFO - Return code: 0 11:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:14 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')]} 11:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:14 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')]} 11:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:14 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45:14 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 11:45:14 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 11:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:14 INFO - 'HOME': '/Users/cltbld', 11:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:14 INFO - 'LOGNAME': 'cltbld', 11:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:14 INFO - 'MOZ_NO_REMOTE': '1', 11:45:14 INFO - 'NO_EM_RESTART': '1', 11:45:14 INFO - 'PAGER': '/bin/cat', 11:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:14 INFO - 'PWD': '/builds/slave/test', 11:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:14 INFO - 'SHELL': '/bin/bash', 11:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:14 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:14 INFO - 'USER': 'cltbld', 11:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:14 INFO - 'XPC_FLAGS': '0x0', 11:45:14 INFO - 'XPC_SERVICE_NAME': '0', 11:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:14 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-J52tNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:14 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)) 11:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:14 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-w4uVcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:14 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)) 11:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:14 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-slv85D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-qgnued-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-vCJeGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-fMhuXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-XPio9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ubrgeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-lmkiHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-uLqXn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1aVmTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:15 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)) 11:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:15 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-GBFN0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:16 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)) 11:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:16 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-oy3oSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:16 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)) 11:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:16 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-_n3R3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:16 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)) 11:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:16 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-mJjlpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:16 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)) 11:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:16 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-M2Zo8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:16 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)) 11:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:16 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-fWljjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:16 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)) 11:45:16 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)) 11:45:16 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)) 11:45:16 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)) 11:45:16 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)) 11:45:16 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)) 11:45:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:45:16 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 11:45:16 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 11:45:16 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 11:45:16 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 11:45:16 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 11:45:16 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 11:45:19 INFO - Downloading blessings-1.6.tar.gz 11:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:45:19 INFO - Installing collected packages: blessings 11:45:19 INFO - Running setup.py install for blessings 11:45:19 INFO - Successfully installed blessings 11:45:19 INFO - Cleaning up... 11:45:19 INFO - Return code: 0 11:45:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:19 INFO - Reading from file tmpfile_stdout 11:45:19 INFO - Current package versions: 11:45:19 INFO - blessings == 1.6 11:45:19 INFO - blobuploader == 1.2.4 11:45:19 INFO - docopt == 0.6.1 11:45:19 INFO - functools32 == 3.2.3-2 11:45:19 INFO - jsonschema == 2.5.1 11:45:19 INFO - manifestparser == 1.1 11:45:19 INFO - mozInstall == 1.12 11:45:19 INFO - mozcrash == 1.0 11:45:19 INFO - mozdebug == 0.1 11:45:19 INFO - mozdevice == 0.48 11:45:19 INFO - mozfile == 1.2 11:45:19 INFO - mozhttpd == 0.7 11:45:19 INFO - mozinfo == 0.9 11:45:19 INFO - mozleak == 0.1 11:45:19 INFO - mozlog == 3.4 11:45:19 INFO - moznetwork == 0.27 11:45:19 INFO - mozprocess == 0.23 11:45:19 INFO - mozprofile == 0.28 11:45:19 INFO - mozrunner == 6.13 11:45:19 INFO - mozscreenshot == 0.1 11:45:19 INFO - mozsystemmonitor == 0.3 11:45:19 INFO - moztest == 0.7 11:45:19 INFO - mozversion == 1.4 11:45:19 INFO - psutil == 3.1.1 11:45:19 INFO - requests == 1.2.3 11:45:19 INFO - wsgiref == 0.1.2 11:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:20 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')]} 11:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:20 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45:20 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 11:45:20 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 11:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:20 INFO - 'HOME': '/Users/cltbld', 11:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:20 INFO - 'LOGNAME': 'cltbld', 11:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:20 INFO - 'MOZ_NO_REMOTE': '1', 11:45:20 INFO - 'NO_EM_RESTART': '1', 11:45:20 INFO - 'PAGER': '/bin/cat', 11:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:20 INFO - 'PWD': '/builds/slave/test', 11:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:20 INFO - 'SHELL': '/bin/bash', 11:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:20 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:20 INFO - 'USER': 'cltbld', 11:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:20 INFO - 'XPC_FLAGS': '0x0', 11:45:20 INFO - 'XPC_SERVICE_NAME': '0', 11:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 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)) 11:45:20 INFO - Cleaning up... 11:45:20 INFO - Return code: 0 11:45:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45:20 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')]} 11:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:21 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')]} 11:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:21 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 0x103417490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad11cb9f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, '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.vMsRHOnw62/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.wIHalFmTsd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 11:45:21 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 11:45:21 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 11:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:21 INFO - 'HOME': '/Users/cltbld', 11:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:21 INFO - 'LOGNAME': 'cltbld', 11:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:21 INFO - 'MOZ_NO_REMOTE': '1', 11:45:21 INFO - 'NO_EM_RESTART': '1', 11:45:21 INFO - 'PAGER': '/bin/cat', 11:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:21 INFO - 'PWD': '/builds/slave/test', 11:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:21 INFO - 'SHELL': '/bin/bash', 11:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:21 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:21 INFO - 'USER': 'cltbld', 11:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:21 INFO - 'XPC_FLAGS': '0x0', 11:45:21 INFO - 'XPC_SERVICE_NAME': '0', 11:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:21 INFO - Cleaning up... 11:45:21 INFO - Return code: 0 11:45:21 INFO - Running post-action listener: _resource_record_post_action 11:45:21 INFO - Running post-action listener: _start_resource_monitoring 11:45:21 INFO - Starting resource monitoring. 11:45:21 INFO - [mozharness: 2016-11-14 19:45:21.821217Z] Finished create-virtualenv step (success) 11:45:21 INFO - [mozharness: 2016-11-14 19:45:21.822201Z] Running install step. 11:45:21 INFO - Running pre-action listener: _resource_record_pre_action 11:45:21 INFO - Running main action method: install 11:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:22 INFO - Reading from file tmpfile_stdout 11:45:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:22 INFO - Reading from file tmpfile_stdout 11:45:22 INFO - Output received: 11:45:22 INFO - Usage: mozinstall [options] installer 11:45:22 INFO - Options: 11:45:22 INFO - -h, --help show this help message and exit 11:45:22 INFO - -d DEST, --destination=DEST 11:45:22 INFO - Directory to install application into. [default: 11:45:22 INFO - "/builds/slave/test"] 11:45:22 INFO - --app=APP Application being installed. [default: firefox] 11:45:22 INFO - mkdir: /builds/slave/test/build/application 11:45:22 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'] 11:45:22 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 11:45:53 INFO - Reading from file tmpfile_stdout 11:45:53 INFO - Output received: 11:45:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:45:53 INFO - Running post-action listener: _resource_record_post_action 11:45:53 INFO - [mozharness: 2016-11-14 19:45:53.803913Z] Finished install step (success) 11:45:53 INFO - [mozharness: 2016-11-14 19:45:53.804049Z] Running run-tests step. 11:45:53 INFO - Running pre-action listener: _resource_record_pre_action 11:45:53 INFO - Running main action method: run_tests 11:45:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:45:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:45:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:45:53 INFO - 2016-11-14 11:45:53.818 screenresolution[1633:7450] starting screenresolution argv=screenresolution get 11:45:53 INFO - 2016-11-14 11:45:53.821 screenresolution[1633:7450] Display 0: 1600x1200x32@60 11:45:53 INFO - 2016-11-14 11:45:53.826 screenresolution[1634:7453] starting screenresolution argv=screenresolution list 11:45:53 INFO - Available Modes on Display 0 11:45:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:45:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:45:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:45:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:45:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:45:54 INFO - Intel Iris: 11:45:54 INFO - Chipset Model: Intel Iris 11:45:54 INFO - Type: GPU 11:45:54 INFO - Bus: Built-In 11:45:54 INFO - VRAM (Dynamic, Max): 1536 MB 11:45:54 INFO - Vendor: Intel (0x8086) 11:45:54 INFO - Device ID: 0x0a2e 11:45:54 INFO - Revision ID: 0x0009 11:45:54 INFO - Displays: 11:45:54 INFO - Display: 11:45:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:45:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:45:54 INFO - Display Serial Number: 1600x1200 60 11:45:54 INFO - Main Display: Yes 11:45:54 INFO - Mirror: Off 11:45:54 INFO - Online: Yes 11:45:54 INFO - Rotation: Supported 11:45:54 INFO - Return code: 0 11:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:54 INFO - Python 2.7.3 11:45:54 INFO - Return code: 0 11:45:54 INFO - grabbing minidump binary from tooltool 11:45:54 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')]} 11:45:54 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 0x10322bd30>, '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 0x103091db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103223b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:54 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 11:45:54 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 11:45:54 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 11:45:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:54 INFO - Return code: 0 11:45:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:45:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:45:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:54 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/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 11:45:54 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/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 11:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vMsRHOnw62/Render', 11:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:54 INFO - 'HOME': '/Users/cltbld', 11:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:54 INFO - 'LOGNAME': 'cltbld', 11:45:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:54 INFO - 'MOZ_NO_REMOTE': '1', 11:45:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:54 INFO - 'NO_EM_RESTART': '1', 11:45:54 INFO - 'PAGER': '/bin/cat', 11:45:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:54 INFO - 'PWD': '/builds/slave/test', 11:45:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:54 INFO - 'SHELL': '/bin/bash', 11:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wIHalFmTsd/Listeners', 11:45:54 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 11:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:54 INFO - 'USER': 'cltbld', 11:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:54 INFO - 'XPC_FLAGS': '0x0', 11:45:54 INFO - 'XPC_SERVICE_NAME': '0', 11:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:54 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/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 11:45:54 INFO - mozversion application_buildid: 20161114081542 11:45:54 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:45:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:45:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:54 INFO - mozversion application_name: Firefox 11:45:54 INFO - mozversion application_remotingname: firefox-dev 11:45:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:45:54 INFO - mozversion application_vendor: Mozilla 11:45:54 INFO - mozversion application_version: 52.0a2 11:45:54 INFO - mozversion platform_buildid: 20161114081542 11:45:54 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:45:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:45:54 INFO - mozversion platform_version: 52.0a2 11:45:54 INFO - using testdate: 1479152754 11:45:54 INFO - actual date: 1479152754 11:45:54 INFO - starting webserver on 'localhost:49272' 11:45:54 INFO - SUITE-START | Running 2 tests 11:45:54 INFO - TEST-START | dromaeo_css 11:45:54 INFO - operating with platform_type : mac_ 11:45:54 INFO - Initialising browser for dromaeo_css test... 11:45:54 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp9NecDp/profile http://localhost:49272/getInfo.html) 11:45:56 ERROR - PROCESS | 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:45:56 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 11:45:56 INFO - PROCESS | 1644 | colorDepth:24 11:45:56 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 11:45:56 INFO - PROCESS | 1644 | __metrics 11:45:57 INFO - PROCESS | 1644 | 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" 11:45:57 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:45:57 INFO - TEST-INFO | 1644: exit 0 11:45:57 INFO - Browser initialized. 11:45:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:57 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp9NecDp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:09 INFO - PROCESS | 1646 | RSS: Main: 217493504 11:46:09 INFO - PROCESS | 1646 | 11:47:00 INFO - PROCESS | 1646 | 1479152820659 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] 11:49:14 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:49:17 INFO - PROCESS | 1646 | RSS: Main: 428216320 11:49:17 INFO - PROCESS | 1646 | 11:52:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:52:21 INFO - PROCESS | 1646 | RSS: Main: 359747584 11:52:21 INFO - PROCESS | 1646 | 11:55:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:55:24 INFO - PROCESS | 1646 | RSS: Main: 346529792 11:55:24 INFO - PROCESS | 1646 | 11:58:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:58:27 INFO - PROCESS | 1646 | RSS: Main: 334049280 11:58:27 INFO - PROCESS | 1646 | 12:01:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 12:01:31 INFO - PROCESS | 1646 | RSS: Main: 317988864 12:01:31 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 12:04:34 INFO - PROCESS | 1646 | RSS: Main: 381861888 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | __start_tp_report 12:04:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 12:04:34 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 12:04:34 INFO - PROCESS | 1646 | |i|pagename|runs| 12:04:34 INFO - PROCESS | 1646 | |0;dojo.html;3007.6541197762263;3305.743817349407;3314.419976504111;3331.7168040716524;3368.124287685201;5735.08238681811;5830.09633506806;5853.912191317134;5859.091840764683;5866.88266234675;5694.629849059808;5724.856878578038;5810.912836307459;5818.650880947135;5820.2433683621175;5222.477752224785;5223.582113430935;5227.5295223429885;5243.632945693803;5295.920561191585;5219.582433405338;5233.450487698794;5315.973420132894;5339.092354299778;5369.7583608737505;5286.259923610678;5306.548943339821;5333.146696528556;5334.67991920486;5338.519533242007;4893.975530122344;4950.628702847265;5287.074761916669;5299.205119232108;5324.1215199492035;5173.948260517384;5273.34083239595;5276.894462110737;5278;5303.840884773463;5947.434993675594;5956.493698035672;5957.642541447527;5959.702014899238;5960.403959604048;6122.977604208209;6151.815445536641;6163.198784158076;6164.568480206387;6169.136320915076;6119.451290860639;6119.502553941423;6144.617461071268;6162.7534898604;6172.105044768528;5861.443162899518;5864.091065884794;5888.352281249059;5934.317553481319;5935.9406405935815;6113.810786210604;6273.592216505958;6289.905651415233;6314.052892066226;6331.68341582919;6088.1476593276975;6111.804454079507;6138.631682098999;6139;6143.218466644623;6146.709191069836;6156.045812899008;6169.074638804215;6248.437640612276;6260.311365749764;5826.563007774434;6126.517673797367;6199.380061993855;6214.720337584819;6234.750609975641;6168.845778855475;6196.256449226032;6206.72069756862;6234.1583886174785;6249.625022498664;4946.802127914915;4955.6531042826655;4967.105920934194;4968.950310496921;4990.675606085593;4478.910421791546;4482.955170448254;4487.551244875552;4488.685791994529;4514.435695538058;5776.768929242868;5803.390643982406;5857.707114644336;5908.645481271137;5973.671448070311;6184.6598437086395;6207.689615519206;6229.345918678564;6231.563790534619;6245.5628106033055;6011;6018.277806663228;6027.9095813562835;6030.246219222598;6058.030715085565;5367.892642147213;5425.810096646598;5431.293931788842;5505.697186654692;5522.641028333145;6135.110179431545;6221.377862213742;6222.0355844844125;6223.626582405071;6318.178636777189;6198.845028874314;6198.876022479435;6209.627422354673;6213.937860621517;6226.968865155645;6170.722317495633;6298.464630506458;6302.960011598218;6319.494440444845;6321.747130114928;6113;6121.632702037892;6140.4428991762525;6162.969185154046;6207.131001659862;6195.039768835838;6234.096056071935;6234.937650623617;6238.157848690369;6239.376062393724;6081.939180608138;6207.379262073937;6215.627062376272;6240.53196010292;6250.874982500415;6134.969325153525;6158.938410616016;6163.722632481459;6221.844453888689;6238.407351301619;6048;6094.055421409688;6123.693815309306;6142.253225532511;6148.1085242640465;5366.865828354323;6047.818565443044;6114;6164.506839452743;6225.968870155621;5976;5983;6012.488938440107;6054.303755068047;6058.4244496772735 12:04:34 INFO - PROCESS | 1646 | |1;ext.html;489.66457976286245;494.41411926866664;502.38959664008246;526.8129813916062;526.8840855011896;30274;31811.363772724562;39070.8046459768;40632.984175395555;40977.795111024476;41796;42208.57791422085;42217.15565688685;42258;42293;9239.445633262008;9396.48319342436;9398.201152902011;9422.057794220591;9427.387219830724;8480.533570653612;8678.566071696421;11106.27809192404;11404.714882127972;11409.657710268664;11332.830007549894;11342.773144537146;11343.319400835935;11352.886471135265;11353.659390218265;8337;11276.887231127666;11324.377159256237;11352.432378381049;11358.659240222807;8477.957610211972;11028.28316159455;11334.149938754545;11340.773184536345;11486.023687986532;39163;39412.40881386781;39426.0143496412;39511.80244098761;39578.40632390516;3276.885309014197;3291.901242962715;3386.373520898617;3475.7393195510185;3887.5723670396233;29513.262168445744;29644.407111857858;29982.85008574965;30214.54678179829;30749.8462507686;2871.6410448693914;2972.7919045666813;2987.4622567937763;3008.8345141017235;3014.8643311051055;433788;438056;438315;438969;439468.60531394917;59105.40894590999;59883.700581496814;59911;59937.70031149816;60016.399836001954;34055.82972085124;34414.655853441145;34622.9613111602;35880;36006.099847504025;15814.9209253953;15938;15965.042097474188;15993.840061599467;16024.439144629881;11055.557777688964;11272.041876440431;11823.645290641294;12085.637430877088;12237.755244895052;16624.58438539022;18619.813801862078;18723.719144212846;19003;19050.428487145407;7502.399808015346;7672.578008209602;7677.088240398703;7710.228977102357;7711.768646940601;864.8659457784054;975.0201047946769;996.1632228927735;1007.596961215505;1066.7973085113804;29746;29839.552406713916;29886.551701724493;29983.400331993238;30508.54237186444;995.571904081252;1028.095276156992;1056.4770438632927;1060.3213943076437;1109.2180013090751;14449.988500805053;15045.097294162386;15372;15427.228638568027;15432.691346173013;686911;691427;692784;693490;693520;55934.72032639811;56348;56384.71807640936;56476.435235647936;56535.43464565384;1323.351557736702;1331.7602831490424;1343.4894739998738;1355.3900744664743;1364.40648317982;28131.859340703166;28821.645773861237;28891.42217155687;28948.42103157967;29165.562516561844;50403.73990650116;50978.23532647087;51019.23471147862;51094.48905510897;51244.74377628088;605889;607955;608248;610483;611569.8264525947;22992.540149197255;23550.528989420458;26019.609705854047;26309;26397.34006649849;34905.9528214154;37546;37685.811570943064;43365.566344336155;46267.537324626326;37255;37266;37371;38416.80791596024;38558.80720596379;36797.89606311815;37234;37332.626673734005;37465.625343746215;37919.86240412792;36348.818255908554;37403.81298093601;37934.051648709006;37938.810305949395;37968.430473542365;30164.245893851952;32513.862014829367;33670.831645841616;33946.64213431435;34290.657093428745;22902.885485573133;24853.378665533506;24968;24995.375115621526;25512.362190945376 12:04:34 INFO - PROCESS | 1646 | |2;jquery.html;350.9894703158903;365.8609728303245;371.34272337961806;380.3761830597819;401.1715806858836;14365.640858978531;14838.40646374145;15560.922195389021;19790.802091979076;20379;18977.52556186096;19855.90072049638;19962.201511939504;20044.1982320707;20120.496987575283;5727.742251598688;5968.522518198533;5969.313528944183;5993.160957465958;6121.020636698129;5149.918517111411;6026.0659597762415;6052.909206361886;6077.1491991121275;6093.725782339783;5684.346300175471;5996.8500787480225;6024.518038556905;6025.066114752199;6038.184845045928;5920.437558431942;6036.879262414771;6046.727897244635;6052.667103309316;6053.092036194562;5048.697078175322;5181.533661970403;5182.119039763249;5255.605829562798;5271.182966640177;24190.516189676284;24217.757822421903;24400.38999025021;24495.897684604235;24762.752372476225;2266.8073213776847;2658.6809582849987;2669.7730692891128;2976.9851150744325;3100.2869340051916;12593.93703031488;14853.777193342108;15140.545783626509;15952.601184970468;16060.036397816168;1807.9276828926827;1862.3586558369177;1883.7080252560875;1897.4023182697545;1902.7050807124917;87240.12759872383;105642;120222.39888800588;126991;128906.99999999907;10054.849177262347;10205.438700871524;10464.319819211727;11190.32858028521;11211.66365009051;13916.791248131287;13982.790258146137;13990.86009139916;13999;14002.85997140036;7823.100343460461;8231;8572.357073219533;8649.351298652626;8722.520261385558;7806.882896756553;8444.61999210037;8517;8614.18165274298;8659.090795466385;5862.886051650173;6090.725917333642;6355.586886852339;6595.802125936134;6738.797836064926;1772.2454769777828;1817.9454616361531;1825.917833697487;1826.7716535433071;1827.1412436154985;902.8194361127801;905.542700936023;913.4062859141611;967.3905439573024;1009.7879445316565;20334.389968300973;22007.339779806633;22086.447838804157;22097.66853497199;22177.55644887093;909.1681111782644;931.2084727981162;939.3987847777428;956.6795123633522;979.5983646704817;10884.782304353868;11066.225364224427;11580.76838463226;11598.88401115995;11664;587452;602968;610214;617872;619277;77772;104492.47753761182;108223;120803;125662;958.5255298627225;965.7875267441292;1011.9949400252951;1013.7566983923805;1013.9543720532594;18662.160202790634;19056.714149287494;20168.59662806765;20173.394798156078;20197.6970345442;48465;49133.54026401196;49246.50753492419;50334.49665503445;50373.74065648388;69164;70468;71154.64422677853;71474;71874.92187617085;5290.841274761763;5643.548516118619;6958;7311.488195826241;7971.402144839276;12739.108262421913;12798.488060477477;13129.474821007434;13550.254735989614;13589.592312230254;10877.12982961377;10917.39954302521;11634;11673.824892626448;11847.940760296144;11053.834192486958;11139.33164010162;11154.553817847196;11188.1608879336;11342.546298148312;9299.395539289924;10345.499902514244;10770.24608277413;11282.153838462313;11410;6955.269696681978;7217.927820721936;7330.926690733025;7990.800229994296;8537.487750734976;10775;10829.350238985686;11054.949779770908;11147.944260278648;11210.27133236337 12:04:34 INFO - PROCESS | 1646 | |3;mootools.html;1421.4882642248788;1438.2664840931125;1584.4216860845795;1731.0998280893944;1789.0339216822915;8193.836123277539;8625.094365091669;8626.482411055342;8637.093105223956;8666.91333086669;7534.698612055525;7772.494787838787;7777.4944628599105;7876.133625301212;8436.957815210915;2096.8217701495355;2128.936131916045;2133.157402825883;2245.9887700561558;2334.3930578049744;2149.0758973641327;2302.1136862307962;2384.153625462962;2384.201292566992;2385.2844146755992;2297.885105744706;2330.0330362899376;2345.5660702769956;2346.3312955807596;2350.1069593554425;2304.5506126305377;2304.5621331946877;2321.5240875620457;2323.3039880886877;2337.439014636492;2331.918382856592;2333.5216280662594;2357.811375089989;2364.869932153731;2365.6096744037213;8321.043080045813;8505.149485051506;8508.702195423193;8533.189347012023;8540.78648033798;5064.797408103672;5227.503387178212;5241.056609810233;5244.108501554707;5246.947530524722;3433.9313213735836;3448.6723761242642;3453.0849324928913;3515.542979412686;3530.3998320285355;1002.4085789384226;1005.602786899178;1038.3199004651965;1040.4069680282241;1056.7833594113188;9642.276829237835;10991.230613857033;11148.21962462628;11152.944235278772;11161.776764464665;4474.105178964221;4587.518310577408;4675.976620116878;4693;4758.547937945889;9545.713628591153;9552.57013434397;9554.14012738843;9577.760555986157;9587.952060239653;5218.556422704037;5233.058049551118;5236.423993360727;5237.528622424;5238.8166414176085;4502;4776.904461910743;4797.4482934462985;4801.039792041536;4845.224764037737;3557.288542291552;3664.7434679572175;3665.0654083209142;3751.080985158599;3794.582595914447;1256.597888675615;1259.7984322508355;1261.8422697162855;1271.3960868587533;1279.1429742072833;805.5287656720767;836.5984327522823;863.4775960543781;879.3185281406833;907.7912080221586;5385.542228910586;5400.432954539795;5532.419095994943;5607.775688972477;5795.88408231833;867.444835305405;878.8549889268327;905.9094090590888;944.4946953379908;945.7257395355407;3643.2531331077066;3726;3733.0480727414338;3740.9064773380337;3755.1738617504107;9922.603095876228;10222.13111885498;10365;10367.896321036844;10374.22193335503;10114.089731924016;10305.793884122275;10324.896751032393;10327.244368457381;10337.896621033844;7891.447598668153;7908.406869484812;7916.08964969036;8000.8799868002025;8014;5373.865653358697;5422.078246697992;5528.226048353154;5532.5020748132865;5699.316082070178;9336.159745622926;9365.859512107187;9400.670976515788;9406.05939406054;9497.572609232462;9417.858732118886;9870.457124858201;9877.407355558402;9879.357841740264;9880.802383952425;7175.282471752783;7258.637068146466;7287.943248229083;7292.817679557841;7300.45246606496;7179.928200718135;7361.374283185775;7845.333146682596;7850.960745196237;7948;7051.541649792747;7143.214246432784;7168.1756597989815;7190.316919892602;7221.927780722125;7069.964650176922;7083.504154709327;7120.252373500915;7187.8858776889665;7244.673989670372;6677.465802735866;6720.32796720324;6780.796576102724;6784.694688739118;6811.182658081062;4773.1408346497965;4799.66402351832;4803.927941080817;4888.413390393175;5009.7996080157845;4753.170188546151;4857.854264372075;4873.610111191026;4879;4902.803887844589 12:04:34 INFO - PROCESS | 1646 | |4;prototype.html;298.65207033805615;303.14815368813635;307.97228249457544;310.5915720827112;315.974722022238;4941.048285927057;5095.974520127404;5100.132977393842;5166.984875898398;5200.999999999995;5030.320906677597;5044.445111037792;5108.770105345259;5191.662541934772;5194.92207616886;3871.0451222132924;3920.764754114748;3925.4308125321954;3928.273269445162;3973.483447151866;3676.0149519259567;3792.184680293736;3920.5687374388795;3932.6067393260732;3956.9208615827665;3730.5709843367954;3883.7087218458587;3895.8831235062994;3902.765834049952;3929.3713005919058;3247.5778148840736;3896.6556537994347;3898.3957486589625;3902.3951287550476;3906.667933225665;2845.3882415280814;3356.1945133167865;3387.6449420231856;3407.6592340765724;3410.215650400397;4757.500462451462;4971.726555039471;4973.030259099477;5049.33371987247;5109.9489005109845;4074.8370065197355;4272.782257056755;4465.732056076646;4476.261416866213;4495.14592227479;5405.432429594875;5408.648437851566;5423.566114710814;5432.375276843174;5435.374931882845;3167.572377729023;3216.5979252593424;3568.6431356864364;3721.832517536717;3756.1548651553453;4952.653314268003;4971.663318240421;5688;5727.541796656257;5759.481646651821;3662.8351724172476;3766.2090960898518;3769.4345848122452;3776.86780962665;3782.791946442917;3282.163048422637;3827.25368553135;3835.961640383616;3853.7109716771356;3864.53625564934;3774.9433758493647;4345.591280871524;4447.2439685253585;4448.1095534397755;4480.118350292885;5016;5356.437574054746;5490.6431081979545;5504.366997795225;5513.724313784295;1135.920875168593;1207.7644859252537;1217.5190799634272;1246.0343233993547;1268.543324403214;748.1732685382683;814.3810703864987;850.9489430634181;899.536738579632;906.3836591117971;3888.591697871739;3985.8206380712936;4549.45406551216;4589.059242855206;4793.161196790547;4617.8383756568355;4892.633052521075;5102.489751024942;5302.231176479466;5335.279737235423;4338.891527711832;4560.566746159109;4807.495213002654;4820.480549770493;4855.417349918032;2368.526294741059;2544;2684.691260505028;2733.7676297514936;2790.734880186379;5033.866615361143;5300.4486993713535;5355.544778693855;5447.455254474521;5460.235567020621;5372.07222063976;5397.3523177218985;5426.620136590401;5432.674039557639;5438.7280635968045;4941.50584941503;5241.292425522582;5442.836714898559;5443.42844001382;5457.890842183134;4259.914801704011;5060.709519072613;5218.686878787133;5282.81510147143;5296.311479507639;4962.925556116589;5196.402413722471;5211.71335576547;5217.50433708797;5223.399309079505;4546.659000574904;4652.441706995182;5316.867078323073;5450.184870590523;5470.316210473691;3305.124142102297;3502.3695734767985;3604.2971620533744;3651.101427257864;3662.633736626316;4712.905741885074;5088.54203121706;5257.7371131442505;5259.947400526099;5267.813857249352;4471.217536930959;4570.9943812361225;4902.240152776325;5046.621503387188;5091.923621145612;4484.75333856628;4492.775361231991;4719.513353293702;4899.902001960012;5095.464976177596;5005.7997680092385;5061.342025536656;5140.845774626767;5268.446813084724;5295.76169072385;5109.835484080462;5244.265802787689;5461.808836690697;5489.65503451641;5496.917546236729;4518.367428559938;4966.553010229097;5344.625876188629;5385.9192112119135;5394.462578165204 12:04:34 INFO - PROCESS | 1646 | |5;yui.html;731.7768080735377;742.5396254322318;748.3788455581868;748.9550626962387;769.8575763483758;14912.403503859847;16441.013539187657;16452.670946581093;16483.34066637333;16503.422380216696;14665.92667036666;14744.189069601194;14757.631059223524;14811.333489992949;14813.333399996998;647.5855452510397;666.6999850067489;802.4984384759525;825.8183199696057;830.7715378270964;801.6713147609481;813.3737022492677;824.4187847567481;828.1015098618007;828.8756686497013;865.6364326982682;865.7489328094845;867.4274978514181;869.0961400143843;869.1048220333067;671.9160104986877;859.6862145316945;861.2421069458899;861.67687117331;861.8664107063415;512.4670342843439;616.2635650397776;632.2349956552576;633.3191818794814;636.0681601453846;14029.158250505003;14070.71858562823;14071.437142514287;14072;14085.577432677037;10053.246006549538;12692.619221423372;12929.806052909214;12976.789321503578;13334.799978000337;11115.499802508826;11255.212135150543;11533.76932461346;11728.824067638992;11791.882081179165;3547.113221694576;3592.7125829933802;3635.8182090895616;3768.2651882882847;3827.7129215308964;79036.60481697612;79716.60141699313;82604.17395826086;85064.99999999937;85413;9952.502374881227;10011.462370179934;10448.42533660656;10480.423576703355;10571.577136914591;19731.50671233202;19970.801751894935;19998.600027999357;20001.59996800056;20005.499862503264;7255.673494692646;7323.304286092813;7336.229695881855;7667.539947603162;7697.499662521918;4107.835686572504;4208.22147902639;4223.1975924574235;4273.1240095780295;4410.845620403271;3376.122208225879;3439.9828000860334;3441.4321636930126;3473.3574288756663;3509.9122521937156;618.5051958433236;628.7704987679556;630.713025573363;631.1479502671357;645.4416929356167;568.3918207517999;606.5147881694627;663.4294506724214;674.2818897873749;677.3632785181914;8357.707480238163;8845.557722113868;8997.775055623531;9004.774880628036;9217.216536594331;616.8434185901435;634.8317695810614;665.1951139121717;670.8121725916751;680.5134328954821;4398.538153493837;4447.688661793643;4450.755208463501;4456.77716114193;4483.125790470827;75570.24429755632;114564.42717786525;115897;116132;119875;67937.98093028608;77794.61102694564;78097.60951195321;97198.51400743093;101828.98171018195;73496;86555;87770.24459510646;88096.11903880879;90541.5472922618;8799.604017819342;8811.33914956368;8818.38271321027;8833;8887.377883548348;55817.44182558123;56060.719696401255;57159.14261286001;58847.70576147092;59064;75491.49017019739;77136;77316;77694.611526942;79880;11049.447527623748;11124.555017799197;11252.606158784403;11272.098232141572;11561.017313528107;12026.879731202926;12036.939815300868;12340.50637974471;12605.87394126047;12829.871701282867;11847.822282665938;11895.76208475843;12255.571055013032;12365.938170309451;12380.442880070239;11779.528818847493;11915.76168476643;12004.519819207135;12382.380880956096;12399.132060756021;11268.492917818881;11353.03499202544;11529.308241505536;11867.821982670093;11923.582674606347;9752.171065459515;9883.456409897524;10191.94904025475;10326.432046237529;10380.688579342632;9637.855432168382;10181.134603558781;10237.539310730886;10239.7440063999;10314.638987635397 12:04:34 INFO - PROCESS | 1646 | __end_tp_report 12:04:34 INFO - PROCESS | 1646 | __start_cc_report 12:04:34 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2595 12:04:34 INFO - PROCESS | 1646 | __end_cc_report 12:04:34 INFO - PROCESS | 1646 | __startTimestamp1479153874458__endTimestamp 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | ------- Summary: start ------- 12:04:34 INFO - PROCESS | 1646 | Number of tests: 6 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5782.26 Median:6058.03 stddev:636.95 (10.5%) stddev-sans-first:600.56 12:04:34 INFO - PROCESS | 1646 | Values: 3007.7 3305.7 3314.4 3331.7 3368.1 5735.1 5830.1 5853.9 5859.1 5866.9 5694.6 5724.9 5810.9 5818.7 5820.2 5222.5 5223.6 5227.5 5243.6 5295.9 5219.6 5233.5 5316.0 5339.1 5369.8 5286.3 5306.5 5333.1 5334.7 5338.5 4894.0 4950.6 5287.1 5299.2 5324.1 5173.9 5273.3 5276.9 5278.0 5303.8 5947.4 5956.5 5957.6 5959.7 5960.4 6123.0 6151.8 6163.2 6164.6 6169.1 6119.5 6119.5 6144.6 6162.8 6172.1 5861.4 5864.1 5888.4 5934.3 5935.9 6113.8 6273.6 6289.9 6314.1 6331.7 6088.1 6111.8 6138.6 6139.0 6143.2 6146.7 6156.0 6169.1 6248.4 6260.3 5826.6 6126.5 6199.4 6214.7 6234.8 6168.8 6196.3 6206.7 6234.2 6249.6 4946.8 4955.7 4967.1 4969.0 4990.7 4478.9 4483.0 4487.6 4488.7 4514.4 5776.8 5803.4 5857.7 5908.6 5973.7 6184.7 6207.7 6229.3 6231.6 6245.6 6011.0 6018.3 6027.9 6030.2 6058.0 5367.9 5425.8 5431.3 5505.7 5522.6 6135.1 6221.4 6222.0 6223.6 6318.2 6198.8 6198.9 6209.6 6213.9 6227.0 6170.7 6298.5 6303.0 6319.5 6321.7 6113.0 6121.6 6140.4 6163.0 6207.1 6195.0 6234.1 6234.9 6238.2 6239.4 6081.9 6207.4 6215.6 6240.5 6250.9 6135.0 6158.9 6163.7 6221.8 6238.4 6048.0 6094.1 6123.7 6142.3 6148.1 5366.9 6047.8 6114.0 6164.5 6226.0 5976.0 5983.0 6012.5 6054.3 6058.4 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:69831.60 Median:19190.85 stddev:157913.57 (822.9%) stddev-sans-first:158270.73 12:04:34 INFO - PROCESS | 1646 | Values: 489.7 494.4 502.4 526.8 526.9 30274.0 31811.4 39070.8 40633.0 40977.8 41796.0 42208.6 42217.2 42258.0 42293.0 9239.4 9396.5 9398.2 9422.1 9427.4 8480.5 8678.6 11106.3 11404.7 11409.7 11332.8 11342.8 11343.3 11352.9 11353.7 8337.0 11276.9 11324.4 11352.4 11358.7 8478.0 11028.3 11334.1 11340.8 11486.0 39163.0 39412.4 39426.0 39511.8 39578.4 3276.9 3291.9 3386.4 3475.7 3887.6 29513.3 29644.4 29982.9 30214.5 30749.8 2871.6 2972.8 2987.5 3008.8 3014.9 433788.0 438056.0 438315.0 438969.0 439468.6 59105.4 59883.7 59911.0 59937.7 60016.4 34055.8 34414.7 34623.0 35880.0 36006.1 15814.9 15938.0 15965.0 15993.8 16024.4 11055.6 11272.0 11823.6 12085.6 12237.8 16624.6 18619.8 18723.7 19003.0 19050.4 7502.4 7672.6 7677.1 7710.2 7711.8 864.9 975.0 996.2 1007.6 1066.8 29746.0 29839.6 29886.6 29983.4 30508.5 995.6 1028.1 1056.5 1060.3 1109.2 14450.0 15045.1 15372.0 15427.2 15432.7 686911.0 691427.0 692784.0 693490.0 693520.0 55934.7 56348.0 56384.7 56476.4 56535.4 1323.4 1331.8 1343.5 1355.4 1364.4 28131.9 28821.6 28891.4 28948.4 29165.6 50403.7 50978.2 51019.2 51094.5 51244.7 605889.0 607955.0 608248.0 610483.0 611569.8 22992.5 23550.5 26019.6 26309.0 26397.3 34906.0 37546.0 37685.8 43365.6 46267.5 37255.0 37266.0 37371.0 38416.8 38558.8 36797.9 37234.0 37332.6 37465.6 37919.9 36348.8 37403.8 37934.1 37938.8 37968.4 30164.2 32513.9 33670.8 33946.6 34290.7 22902.9 24853.4 24968.0 24995.4 25512.4 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:34332.00 Median:24629.33 stddev:100729.39 (409.0%) stddev-sans-first:100979.65 12:04:34 INFO - PROCESS | 1646 | Values: 351.0 365.9 371.3 380.4 401.2 14365.6 14838.4 15560.9 19790.8 20379.0 18977.5 19855.9 19962.2 20044.2 20120.5 5727.7 5968.5 5969.3 5993.2 6121.0 5149.9 6026.1 6052.9 6077.1 6093.7 5684.3 5996.9 6024.5 6025.1 6038.2 5920.4 6036.9 6046.7 6052.7 6053.1 5048.7 5181.5 5182.1 5255.6 5271.2 24190.5 24217.8 24400.4 24495.9 24762.8 2266.8 2658.7 2669.8 2977.0 3100.3 12593.9 14853.8 15140.5 15952.6 16060.0 1807.9 1862.4 1883.7 1897.4 1902.7 87240.1 105642.0 120222.4 126991.0 128907.0 10054.8 10205.4 10464.3 11190.3 11211.7 13916.8 13982.8 13990.9 13999.0 14002.9 7823.1 8231.0 8572.4 8649.4 8722.5 7806.9 8444.6 8517.0 8614.2 8659.1 5862.9 6090.7 6355.6 6595.8 6738.8 1772.2 1817.9 1825.9 1826.8 1827.1 902.8 905.5 913.4 967.4 1009.8 20334.4 22007.3 22086.4 22097.7 22177.6 909.2 931.2 939.4 956.7 979.6 10884.8 11066.2 11580.8 11598.9 11664.0 587452.0 602968.0 610214.0 617872.0 619277.0 77772.0 104492.5 108223.0 120803.0 125662.0 958.5 965.8 1012.0 1013.8 1014.0 18662.2 19056.7 20168.6 20173.4 20197.7 48465.0 49133.5 49246.5 50334.5 50373.7 69164.0 70468.0 71154.6 71474.0 71874.9 5290.8 5643.5 6958.0 7311.5 7971.4 12739.1 12798.5 13129.5 13550.3 13589.6 10877.1 10917.4 11634.0 11673.8 11847.9 11053.8 11139.3 11154.6 11188.2 11342.5 9299.4 10345.5 10770.2 11282.2 11410.0 6955.3 7217.9 7330.9 7990.8 8537.5 10775.0 10829.4 11054.9 11147.9 11210.3 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5487.31 Median:5230.28 stddev:3031.24 (58.0%) stddev-sans-first:3024.34 12:04:34 INFO - PROCESS | 1646 | Values: 1421.5 1438.3 1584.4 1731.1 1789.0 8193.8 8625.1 8626.5 8637.1 8666.9 7534.7 7772.5 7777.5 7876.1 8437.0 2096.8 2128.9 2133.2 2246.0 2334.4 2149.1 2302.1 2384.2 2384.2 2385.3 2297.9 2330.0 2345.6 2346.3 2350.1 2304.6 2304.6 2321.5 2323.3 2337.4 2331.9 2333.5 2357.8 2364.9 2365.6 8321.0 8505.1 8508.7 8533.2 8540.8 5064.8 5227.5 5241.1 5244.1 5246.9 3433.9 3448.7 3453.1 3515.5 3530.4 1002.4 1005.6 1038.3 1040.4 1056.8 9642.3 10991.2 11148.2 11152.9 11161.8 4474.1 4587.5 4676.0 4693.0 4758.5 9545.7 9552.6 9554.1 9577.8 9588.0 5218.6 5233.1 5236.4 5237.5 5238.8 4502.0 4776.9 4797.4 4801.0 4845.2 3557.3 3664.7 3665.1 3751.1 3794.6 1256.6 1259.8 1261.8 1271.4 1279.1 805.5 836.6 863.5 879.3 907.8 5385.5 5400.4 5532.4 5607.8 5795.9 867.4 878.9 905.9 944.5 945.7 3643.3 3726.0 3733.0 3740.9 3755.2 9922.6 10222.1 10365.0 10367.9 10374.2 10114.1 10305.8 10324.9 10327.2 10337.9 7891.4 7908.4 7916.1 8000.9 8014.0 5373.9 5422.1 5528.2 5532.5 5699.3 9336.2 9365.9 9400.7 9406.1 9497.6 9417.9 9870.5 9877.4 9879.4 9880.8 7175.3 7258.6 7287.9 7292.8 7300.5 7179.9 7361.4 7845.3 7851.0 7948.0 7051.5 7143.2 7168.2 7190.3 7221.9 7070.0 7083.5 7120.3 7187.9 7244.7 6677.5 6720.3 6780.8 6784.7 6811.2 4773.1 4799.7 4803.9 4888.4 5009.8 4753.2 4857.9 4873.6 4879.0 4902.8 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4277.10 Median:4837.95 stddev:1298.93 (26.8%) stddev-sans-first:1267.79 12:04:34 INFO - PROCESS | 1646 | Values: 298.7 303.1 308.0 310.6 316.0 4941.0 5096.0 5100.1 5167.0 5201.0 5030.3 5044.4 5108.8 5191.7 5194.9 3871.0 3920.8 3925.4 3928.3 3973.5 3676.0 3792.2 3920.6 3932.6 3956.9 3730.6 3883.7 3895.9 3902.8 3929.4 3247.6 3896.7 3898.4 3902.4 3906.7 2845.4 3356.2 3387.6 3407.7 3410.2 4757.5 4971.7 4973.0 5049.3 5109.9 4074.8 4272.8 4465.7 4476.3 4495.1 5405.4 5408.6 5423.6 5432.4 5435.4 3167.6 3216.6 3568.6 3721.8 3756.2 4952.7 4971.7 5688.0 5727.5 5759.5 3662.8 3766.2 3769.4 3776.9 3782.8 3282.2 3827.3 3836.0 3853.7 3864.5 3774.9 4345.6 4447.2 4448.1 4480.1 5016.0 5356.4 5490.6 5504.4 5513.7 1135.9 1207.8 1217.5 1246.0 1268.5 748.2 814.4 850.9 899.5 906.4 3888.6 3985.8 4549.5 4589.1 4793.2 4617.8 4892.6 5102.5 5302.2 5335.3 4338.9 4560.6 4807.5 4820.5 4855.4 2368.5 2544.0 2684.7 2733.8 2790.7 5033.9 5300.4 5355.5 5447.5 5460.2 5372.1 5397.4 5426.6 5432.7 5438.7 4941.5 5241.3 5442.8 5443.4 5457.9 4259.9 5060.7 5218.7 5282.8 5296.3 4962.9 5196.4 5211.7 5217.5 5223.4 4546.7 4652.4 5316.9 5450.2 5470.3 3305.1 3502.4 3604.3 3651.1 3662.6 4712.9 5088.5 5257.7 5259.9 5267.8 4471.2 4571.0 4902.2 5046.6 5091.9 4484.8 4492.8 4719.5 4899.9 5095.5 5005.8 5061.3 5140.8 5268.4 5295.8 5109.8 5244.3 5461.8 5489.7 5496.9 4518.4 4966.6 5344.6 5385.9 5394.5 12:04:34 INFO - PROCESS | 1646 | 12:04:34 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20051.14 Median:2497.80 stddev:29396.15 (1176.9%) stddev-sans-first:29442.82 12:04:34 INFO - PROCESS | 1646 | Values: 731.8 742.5 748.4 749.0 769.9 14912.4 16441.0 16452.7 16483.3 16503.4 14665.9 14744.2 14757.6 14811.3 14813.3 647.6 666.7 802.5 825.8 830.8 801.7 813.4 824.4 828.1 828.9 865.6 865.7 867.4 869.1 869.1 671.9 859.7 861.2 861.7 861.9 512.5 616.3 632.2 633.3 636.1 14029.2 14070.7 14071.4 14072.0 14085.6 10053.2 12692.6 12929.8 12976.8 13334.8 11115.5 11255.2 11533.8 11728.8 11791.9 3547.1 3592.7 3635.8 3768.3 3827.7 79036.6 79716.6 82604.2 85065.0 85413.0 9952.5 10011.5 10448.4 10480.4 10571.6 19731.5 19970.8 19998.6 20001.6 20005.5 7255.7 7323.3 7336.2 7667.5 7697.5 4107.8 4208.2 4223.2 4273.1 4410.8 3376.1 3440.0 3441.4 3473.4 3509.9 618.5 628.8 630.7 631.1 645.4 568.4 606.5 663.4 674.3 677.4 8357.7 8845.6 8997.8 9004.8 9217.2 616.8 634.8 665.2 670.8 680.5 4398.5 4447.7 4450.8 4456.8 4483.1 75570.2 114564.4 115897.0 116132.0 119875.0 67938.0 77794.6 78097.6 97198.5 101829.0 73496.0 86555.0 87770.2 88096.1 90541.5 8799.6 8811.3 8818.4 8833.0 8887.4 55817.4 56060.7 57159.1 58847.7 59064.0 75491.5 77136.0 77316.0 77694.6 79880.0 11049.4 11124.6 11252.6 11272.1 11561.0 12026.9 12036.9 12340.5 12605.9 12829.9 11847.8 11895.8 12255.6 12365.9 12380.4 11779.5 11915.8 12004.5 12382.4 12399.1 11268.5 11353.0 11529.3 11867.8 11923.6 9752.2 9883.5 10191.9 10326.4 10380.7 9637.9 10181.1 10237.5 10239.7 10314.6 12:04:34 INFO - PROCESS | 1646 | -------- Summary: end -------- 12:04:34 INFO - PROCESS | 1646 | 12:04:35 INFO - TEST-INFO | 1646: exit 0 12:04:35 INFO - TEST-OK | dromaeo_css | took 1120667ms 12:04:35 INFO - TEST-START | kraken 12:04:35 INFO - operating with platform_type : mac_ 12:04:35 INFO - Initialising browser for kraken test... 12:04:35 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp9YsEf4/profile http://localhost:49272/getInfo.html) 12:04:36 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:04:37 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 12:04:37 INFO - PROCESS | 1657 | colorDepth:24 12:04:37 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 12:04:37 INFO - PROCESS | 1657 | __metrics 12:04:37 INFO - PROCESS | 1657 | 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" 12:04:37 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:04:38 INFO - TEST-INFO | 1657: exit 0 12:04:38 INFO - Browser initialized. 12:04:38 INFO - Running cycle 1/1 for kraken test... 12:04:38 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp9YsEf4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:50 INFO - PROCESS | 1658 | RSS: Main: 217632768 12:04:50 INFO - PROCESS | 1658 | 12:04:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:53 INFO - PROCESS | 1658 | RSS: Main: 267464704 12:04:53 INFO - PROCESS | 1658 | 12:04:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 12:04:57 INFO - PROCESS | 1658 | RSS: Main: 276959232 12:04:57 INFO - PROCESS | 1658 | 12:05:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 12:05:01 INFO - PROCESS | 1658 | RSS: Main: 373473280 12:05:01 INFO - PROCESS | 1658 | 12:05:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 12:05:03 INFO - PROCESS | 1658 | RSS: Main: 276905984 12:05:03 INFO - PROCESS | 1658 | 12:05:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:05:06 INFO - PROCESS | 1658 | RSS: Main: 279375872 12:05:06 INFO - PROCESS | 1658 | 12:05:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 12:05:09 INFO - PROCESS | 1658 | RSS: Main: 318951424 12:05:09 INFO - PROCESS | 1658 | 12:05:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 12:05:13 INFO - PROCESS | 1658 | RSS: Main: 319856640 12:05:13 INFO - PROCESS | 1658 | 12:05:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 12:05:16 INFO - PROCESS | 1658 | RSS: Main: 317116416 12:05:16 INFO - PROCESS | 1658 | 12:05:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:05:18 INFO - PROCESS | 1658 | RSS: Main: 296546304 12:05:18 INFO - PROCESS | 1658 | 12:05:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:05:21 INFO - PROCESS | 1658 | RSS: Main: 298156032 12:05:21 INFO - PROCESS | 1658 | 12:05:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:05:24 INFO - PROCESS | 1658 | RSS: Main: 301092864 12:05:24 INFO - PROCESS | 1658 | 12:05:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:05:27 INFO - PROCESS | 1658 | RSS: Main: 308547584 12:05:27 INFO - PROCESS | 1658 | 12:05:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:05:31 INFO - PROCESS | 1658 | RSS: Main: 308707328 12:05:31 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 12:05:33 INFO - PROCESS | 1658 | RSS: Main: 351956992 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | __start_tp_report 12:05:33 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 12:05:33 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 12:05:33 INFO - PROCESS | 1658 | |i|pagename|runs| 12:05:33 INFO - PROCESS | 1658 | |0;ai-astar;115;114;116;115;115;117;114;116;114;112 12:05:33 INFO - PROCESS | 1658 | |1;audio-beat-detection;141;112;111;140;112;111;105;111;142;109 12:05:33 INFO - PROCESS | 1658 | |2;audio-dft;183;185;165;251;255;199;185;185;185;185 12:05:33 INFO - PROCESS | 1658 | |3;audio-fft;80;60;58;88;72;59;58;59;82;58 12:05:33 INFO - PROCESS | 1658 | |4;audio-oscillator;89;69;94;69;68;70;89;67;68;94 12:05:33 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;87;88;85;87;84;87;84;85;83 12:05:33 INFO - PROCESS | 1658 | |6;imaging-darkroom;92;93;93;93;93;93;94;93;94;92 12:05:33 INFO - PROCESS | 1658 | |7;imaging-desaturate;84;85;79;79;84;81;82;86;81;84 12:05:33 INFO - PROCESS | 1658 | |8;json-parse-financial;58;54;53;54;54;58;57;56;56;56 12:05:33 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;76;80;73;73;69;70;69;74;69 12:05:33 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;84;96;99;87;86;98;100;99;100;88 12:05:33 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;148;147;145;145;146;151;146;150;215;168 12:05:33 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;207;169;167;166;184;217;202;167;170;166 12:05:33 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;68;76;84;85;83;70;66;65;67 12:05:33 INFO - PROCESS | 1658 | __end_tp_report 12:05:33 INFO - PROCESS | 1658 | __start_cc_report 12:05:33 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2004 12:05:33 INFO - PROCESS | 1658 | __end_cc_report 12:05:33 INFO - PROCESS | 1658 | __startTimestamp1479153933592__endTimestamp 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | ------- Summary: start ------- 12:05:33 INFO - PROCESS | 1658 | Number of tests: 14 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:1.48 12:05:33 INFO - PROCESS | 1658 | Values: 115.0 114.0 116.0 115.0 115.0 117.0 114.0 116.0 114.0 112.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:112.00 stddev:15.05 (13.4%) stddev-sans-first:13.78 12:05:33 INFO - PROCESS | 1658 | Values: 141.0 112.0 111.0 140.0 112.0 111.0 105.0 111.0 142.0 109.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:197.80 Median:185.00 stddev:30.22 (16.3%) stddev-sans-first:31.57 12:05:33 INFO - PROCESS | 1658 | Values: 183.0 185.0 165.0 251.0 255.0 199.0 185.0 185.0 185.0 185.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.40 Median:66.00 stddev:11.92 (18.1%) stddev-sans-first:11.74 12:05:33 INFO - PROCESS | 1658 | Values: 80.0 60.0 58.0 88.0 72.0 59.0 58.0 59.0 82.0 58.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:12.02 (15.1%) stddev-sans-first:12.03 12:05:33 INFO - PROCESS | 1658 | Values: 89.0 69.0 94.0 69.0 68.0 70.0 89.0 67.0 68.0 94.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.70 (2.0%) stddev-sans-first:1.74 12:05:33 INFO - PROCESS | 1658 | Values: 87.0 87.0 88.0 85.0 87.0 84.0 87.0 84.0 85.0 83.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 12:05:33 INFO - PROCESS | 1658 | Values: 92.0 93.0 93.0 93.0 93.0 93.0 94.0 93.0 94.0 92.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:82.50 Median:84.00 stddev:2.46 (2.9%) stddev-sans-first:2.55 12:05:33 INFO - PROCESS | 1658 | Values: 84.0 85.0 79.0 79.0 84.0 81.0 82.0 86.0 81.0 84.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.66 12:05:33 INFO - PROCESS | 1658 | Values: 58.0 54.0 53.0 54.0 54.0 58.0 57.0 56.0 56.0 56.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:73.00 stddev:4.29 (5.9%) stddev-sans-first:3.78 12:05:33 INFO - PROCESS | 1658 | Values: 65.0 76.0 80.0 73.0 73.0 69.0 70.0 69.0 74.0 69.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:92.00 stddev:6.58 (7.2%) stddev-sans-first:5.97 12:05:33 INFO - PROCESS | 1658 | Values: 84.0 96.0 99.0 87.0 86.0 98.0 100.0 99.0 100.0 88.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:156.10 Median:149.00 stddev:21.79 (14.6%) stddev-sans-first:22.91 12:05:33 INFO - PROCESS | 1658 | Values: 148.0 147.0 145.0 145.0 146.0 151.0 146.0 150.0 215.0 168.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:177.00 stddev:19.79 (11.2%) stddev-sans-first:18.72 12:05:33 INFO - PROCESS | 1658 | Values: 207.0 169.0 167.0 166.0 184.0 217.0 202.0 167.0 170.0 166.0 12:05:33 INFO - PROCESS | 1658 | 12:05:33 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:8.12 (11.1%) stddev-sans-first:8.30 12:05:33 INFO - PROCESS | 1658 | Values: 67.0 68.0 76.0 84.0 85.0 83.0 70.0 66.0 65.0 67.0 12:05:33 INFO - PROCESS | 1658 | -------- Summary: end -------- 12:05:33 INFO - PROCESS | 1658 | 12:05:34 INFO - TEST-INFO | 1658: exit 0 12:05:34 INFO - TEST-OK | kraken | took 59560ms 12:05:34 INFO - SUITE-END | took 1180s 12:05:34 INFO - Completed test suite (00:19:40) 12:05:34 INFO - javascript benchmark 12:05:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.6541197762263, 3305.743817349407, 3314.419976504111, 3331.7168040716524, 3368.124287685201, 5735.08238681811, 5830.09633506806, 5853.912191317134, 5859.091840764683, 5866.88266234675, 5694.629849059808, 5724.856878578038, 5810.912836307459, 5818.650880947135, 5820.2433683621175, 5222.477752224785, 5223.582113430935, 5227.5295223429885, 5243.632945693803, 5295.920561191585, 5219.582433405338, 5233.450487698794, 5315.973420132894, 5339.092354299778, 5369.7583608737505, 5286.259923610678, 5306.548943339821, 5333.146696528556, 5334.67991920486, 5338.519533242007, 4893.975530122344, 4950.628702847265, 5287.074761916669, 5299.205119232108, 5324.1215199492035, 5173.948260517384, 5273.34083239595, 5276.894462110737, 5278.0, 5303.840884773463, 5947.434993675594, 5956.493698035672, 5957.642541447527, 5959.702014899238, 5960.403959604048, 6122.977604208209, 6151.815445536641, 6163.198784158076, 6164.568480206387, 6169.136320915076, 6119.451290860639, 6119.502553941423, 6144.617461071268, 6162.7534898604, 6172.105044768528, 5861.443162899518, 5864.091065884794, 5888.352281249059, 5934.317553481319, 5935.9406405935815, 6113.810786210604, 6273.592216505958, 6289.905651415233, 6314.052892066226, 6331.68341582919, 6088.1476593276975, 6111.804454079507, 6138.631682098999, 6139.0, 6143.218466644623, 6146.709191069836, 6156.045812899008, 6169.074638804215, 6248.437640612276, 6260.311365749764, 5826.563007774434, 6126.517673797367, 6199.380061993855, 6214.720337584819, 6234.750609975641, 6168.845778855475, 6196.256449226032, 6206.72069756862, 6234.1583886174785, 6249.625022498664, 4946.802127914915, 4955.6531042826655, 4967.105920934194, 4968.950310496921, 4990.675606085593, 4478.910421791546, 4482.955170448254, 4487.551244875552, 4488.685791994529, 4514.435695538058, 5776.768929242868, 5803.390643982406, 5857.707114644336, 5908.645481271137, 5973.671448070311, 6184.6598437086395, 6207.689615519206, 6229.345918678564, 6231.563790534619, 6245.5628106033055, 6011.0, 6018.277806663228, 6027.9095813562835, 6030.246219222598, 6058.030715085565, 5367.892642147213, 5425.810096646598, 5431.293931788842, 5505.697186654692, 5522.641028333145, 6135.110179431545, 6221.377862213742, 6222.0355844844125, 6223.626582405071, 6318.178636777189, 6198.845028874314, 6198.876022479435, 6209.627422354673, 6213.937860621517, 6226.968865155645, 6170.722317495633, 6298.464630506458, 6302.960011598218, 6319.494440444845, 6321.747130114928, 6113.0, 6121.632702037892, 6140.4428991762525, 6162.969185154046, 6207.131001659862, 6195.039768835838, 6234.096056071935, 6234.937650623617, 6238.157848690369, 6239.376062393724, 6081.939180608138, 6207.379262073937, 6215.627062376272, 6240.53196010292, 6250.874982500415, 6134.969325153525, 6158.938410616016, 6163.722632481459, 6221.844453888689, 6238.407351301619, 6048.0, 6094.055421409688, 6123.693815309306, 6142.253225532511, 6148.1085242640465, 5366.865828354323, 6047.818565443044, 6114.0, 6164.506839452743, 6225.968870155621, 5976.0, 5983.0, 6012.488938440107, 6054.303755068047, 6058.4244496772735], "value": 5739.992171179123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.66457976286245, 494.41411926866664, 502.38959664008246, 526.8129813916062, 526.8840855011896, 30274.0, 31811.363772724562, 39070.8046459768, 40632.984175395555, 40977.795111024476, 41796.0, 42208.57791422085, 42217.15565688685, 42258.0, 42293.0, 9239.445633262008, 9396.48319342436, 9398.201152902011, 9422.057794220591, 9427.387219830724, 8480.533570653612, 8678.566071696421, 11106.27809192404, 11404.714882127972, 11409.657710268664, 11332.830007549894, 11342.773144537146, 11343.319400835935, 11352.886471135265, 11353.659390218265, 8337.0, 11276.887231127666, 11324.377159256237, 11352.432378381049, 11358.659240222807, 8477.957610211972, 11028.28316159455, 11334.149938754545, 11340.773184536345, 11486.023687986532, 39163.0, 39412.40881386781, 39426.0143496412, 39511.80244098761, 39578.40632390516, 3276.885309014197, 3291.901242962715, 3386.373520898617, 3475.7393195510185, 3887.5723670396233, 29513.262168445744, 29644.407111857858, 29982.85008574965, 30214.54678179829, 30749.8462507686, 2871.6410448693914, 2972.7919045666813, 2987.4622567937763, 3008.8345141017235, 3014.8643311051055, 433788.0, 438056.0, 438315.0, 438969.0, 439468.60531394917, 59105.40894590999, 59883.700581496814, 59911.0, 59937.70031149816, 60016.399836001954, 34055.82972085124, 34414.655853441145, 34622.9613111602, 35880.0, 36006.099847504025, 15814.9209253953, 15938.0, 15965.042097474188, 15993.840061599467, 16024.439144629881, 11055.557777688964, 11272.041876440431, 11823.645290641294, 12085.637430877088, 12237.755244895052, 16624.58438539022, 18619.813801862078, 18723.719144212846, 19003.0, 19050.428487145407, 7502.399808015346, 7672.578008209602, 7677.088240398703, 7710.228977102357, 7711.768646940601, 864.8659457784054, 975.0201047946769, 996.1632228927735, 1007.596961215505, 1066.7973085113804, 29746.0, 29839.552406713916, 29886.551701724493, 29983.400331993238, 30508.54237186444, 995.571904081252, 1028.095276156992, 1056.4770438632927, 1060.3213943076437, 1109.2180013090751, 14449.988500805053, 15045.097294162386, 15372.0, 15427.228638568027, 15432.691346173013, 686911.0, 691427.0, 692784.0, 693490.0, 693520.0, 55934.72032639811, 56348.0, 56384.71807640936, 56476.435235647936, 56535.43464565384, 1323.351557736702, 1331.7602831490424, 1343.4894739998738, 1355.3900744664743, 1364.40648317982, 28131.859340703166, 28821.645773861237, 28891.42217155687, 28948.42103157967, 29165.562516561844, 50403.73990650116, 50978.23532647087, 51019.23471147862, 51094.48905510897, 51244.74377628088, 605889.0, 607955.0, 608248.0, 610483.0, 611569.8264525947, 22992.540149197255, 23550.528989420458, 26019.609705854047, 26309.0, 26397.34006649849, 34905.9528214154, 37546.0, 37685.811570943064, 43365.566344336155, 46267.537324626326, 37255.0, 37266.0, 37371.0, 38416.80791596024, 38558.80720596379, 36797.89606311815, 37234.0, 37332.626673734005, 37465.625343746215, 37919.86240412792, 36348.818255908554, 37403.81298093601, 37934.051648709006, 37938.810305949395, 37968.430473542365, 30164.245893851952, 32513.862014829367, 33670.831645841616, 33946.64213431435, 34290.657093428745, 22902.885485573133, 24853.378665533506, 24968.0, 24995.375115621526, 25512.362190945376], "value": 19490.771855409537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9894703158903, 365.8609728303245, 371.34272337961806, 380.3761830597819, 401.1715806858836, 14365.640858978531, 14838.40646374145, 15560.922195389021, 19790.802091979076, 20379.0, 18977.52556186096, 19855.90072049638, 19962.201511939504, 20044.1982320707, 20120.496987575283, 5727.742251598688, 5968.522518198533, 5969.313528944183, 5993.160957465958, 6121.020636698129, 5149.918517111411, 6026.0659597762415, 6052.909206361886, 6077.1491991121275, 6093.725782339783, 5684.346300175471, 5996.8500787480225, 6024.518038556905, 6025.066114752199, 6038.184845045928, 5920.437558431942, 6036.879262414771, 6046.727897244635, 6052.667103309316, 6053.092036194562, 5048.697078175322, 5181.533661970403, 5182.119039763249, 5255.605829562798, 5271.182966640177, 24190.516189676284, 24217.757822421903, 24400.38999025021, 24495.897684604235, 24762.752372476225, 2266.8073213776847, 2658.6809582849987, 2669.7730692891128, 2976.9851150744325, 3100.2869340051916, 12593.93703031488, 14853.777193342108, 15140.545783626509, 15952.601184970468, 16060.036397816168, 1807.9276828926827, 1862.3586558369177, 1883.7080252560875, 1897.4023182697545, 1902.7050807124917, 87240.12759872383, 105642.0, 120222.39888800588, 126991.0, 128906.99999999907, 10054.849177262347, 10205.438700871524, 10464.319819211727, 11190.32858028521, 11211.66365009051, 13916.791248131287, 13982.790258146137, 13990.86009139916, 13999.0, 14002.85997140036, 7823.100343460461, 8231.0, 8572.357073219533, 8649.351298652626, 8722.520261385558, 7806.882896756553, 8444.61999210037, 8517.0, 8614.18165274298, 8659.090795466385, 5862.886051650173, 6090.725917333642, 6355.586886852339, 6595.802125936134, 6738.797836064926, 1772.2454769777828, 1817.9454616361531, 1825.917833697487, 1826.7716535433071, 1827.1412436154985, 902.8194361127801, 905.542700936023, 913.4062859141611, 967.3905439573024, 1009.7879445316565, 20334.389968300973, 22007.339779806633, 22086.447838804157, 22097.66853497199, 22177.55644887093, 909.1681111782644, 931.2084727981162, 939.3987847777428, 956.6795123633522, 979.5983646704817, 10884.782304353868, 11066.225364224427, 11580.76838463226, 11598.88401115995, 11664.0, 587452.0, 602968.0, 610214.0, 617872.0, 619277.0, 77772.0, 104492.47753761182, 108223.0, 120803.0, 125662.0, 958.5255298627225, 965.7875267441292, 1011.9949400252951, 1013.7566983923805, 1013.9543720532594, 18662.160202790634, 19056.714149287494, 20168.59662806765, 20173.394798156078, 20197.6970345442, 48465.0, 49133.54026401196, 49246.50753492419, 50334.49665503445, 50373.74065648388, 69164.0, 70468.0, 71154.64422677853, 71474.0, 71874.92187617085, 5290.841274761763, 5643.548516118619, 6958.0, 7311.488195826241, 7971.402144839276, 12739.108262421913, 12798.488060477477, 13129.474821007434, 13550.254735989614, 13589.592312230254, 10877.12982961377, 10917.39954302521, 11634.0, 11673.824892626448, 11847.940760296144, 11053.834192486958, 11139.33164010162, 11154.553817847196, 11188.1608879336, 11342.546298148312, 9299.395539289924, 10345.499902514244, 10770.24608277413, 11282.153838462313, 11410.0, 6955.269696681978, 7217.927820721936, 7330.926690733025, 7990.800229994296, 8537.487750734976, 10775.0, 10829.350238985686, 11054.949779770908, 11147.944260278648, 11210.27133236337], "value": 9566.986559783863, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.4882642248788, 1438.2664840931125, 1584.4216860845795, 1731.0998280893944, 1789.0339216822915, 8193.836123277539, 8625.094365091669, 8626.482411055342, 8637.093105223956, 8666.91333086669, 7534.698612055525, 7772.494787838787, 7777.4944628599105, 7876.133625301212, 8436.957815210915, 2096.8217701495355, 2128.936131916045, 2133.157402825883, 2245.9887700561558, 2334.3930578049744, 2149.0758973641327, 2302.1136862307962, 2384.153625462962, 2384.201292566992, 2385.2844146755992, 2297.885105744706, 2330.0330362899376, 2345.5660702769956, 2346.3312955807596, 2350.1069593554425, 2304.5506126305377, 2304.5621331946877, 2321.5240875620457, 2323.3039880886877, 2337.439014636492, 2331.918382856592, 2333.5216280662594, 2357.811375089989, 2364.869932153731, 2365.6096744037213, 8321.043080045813, 8505.149485051506, 8508.702195423193, 8533.189347012023, 8540.78648033798, 5064.797408103672, 5227.503387178212, 5241.056609810233, 5244.108501554707, 5246.947530524722, 3433.9313213735836, 3448.6723761242642, 3453.0849324928913, 3515.542979412686, 3530.3998320285355, 1002.4085789384226, 1005.602786899178, 1038.3199004651965, 1040.4069680282241, 1056.7833594113188, 9642.276829237835, 10991.230613857033, 11148.21962462628, 11152.944235278772, 11161.776764464665, 4474.105178964221, 4587.518310577408, 4675.976620116878, 4693.0, 4758.547937945889, 9545.713628591153, 9552.57013434397, 9554.14012738843, 9577.760555986157, 9587.952060239653, 5218.556422704037, 5233.058049551118, 5236.423993360727, 5237.528622424, 5238.8166414176085, 4502.0, 4776.904461910743, 4797.4482934462985, 4801.039792041536, 4845.224764037737, 3557.288542291552, 3664.7434679572175, 3665.0654083209142, 3751.080985158599, 3794.582595914447, 1256.597888675615, 1259.7984322508355, 1261.8422697162855, 1271.3960868587533, 1279.1429742072833, 805.5287656720767, 836.5984327522823, 863.4775960543781, 879.3185281406833, 907.7912080221586, 5385.542228910586, 5400.432954539795, 5532.419095994943, 5607.775688972477, 5795.88408231833, 867.444835305405, 878.8549889268327, 905.9094090590888, 944.4946953379908, 945.7257395355407, 3643.2531331077066, 3726.0, 3733.0480727414338, 3740.9064773380337, 3755.1738617504107, 9922.603095876228, 10222.13111885498, 10365.0, 10367.896321036844, 10374.22193335503, 10114.089731924016, 10305.793884122275, 10324.896751032393, 10327.244368457381, 10337.896621033844, 7891.447598668153, 7908.406869484812, 7916.08964969036, 8000.8799868002025, 8014.0, 5373.865653358697, 5422.078246697992, 5528.226048353154, 5532.5020748132865, 5699.316082070178, 9336.159745622926, 9365.859512107187, 9400.670976515788, 9406.05939406054, 9497.572609232462, 9417.858732118886, 9870.457124858201, 9877.407355558402, 9879.357841740264, 9880.802383952425, 7175.282471752783, 7258.637068146466, 7287.943248229083, 7292.817679557841, 7300.45246606496, 7179.928200718135, 7361.374283185775, 7845.333146682596, 7850.960745196237, 7948.0, 7051.541649792747, 7143.214246432784, 7168.1756597989815, 7190.316919892602, 7221.927780722125, 7069.964650176922, 7083.504154709327, 7120.252373500915, 7187.8858776889665, 7244.673989670372, 6677.465802735866, 6720.32796720324, 6780.796576102724, 6784.694688739118, 6811.182658081062, 4773.1408346497965, 4799.66402351832, 4803.927941080817, 4888.413390393175, 5009.7996080157845, 4753.170188546151, 4857.854264372075, 4873.610111191026, 4879.0, 4902.803887844589], "value": 4431.009314460102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.65207033805615, 303.14815368813635, 307.97228249457544, 310.5915720827112, 315.974722022238, 4941.048285927057, 5095.974520127404, 5100.132977393842, 5166.984875898398, 5200.999999999995, 5030.320906677597, 5044.445111037792, 5108.770105345259, 5191.662541934772, 5194.92207616886, 3871.0451222132924, 3920.764754114748, 3925.4308125321954, 3928.273269445162, 3973.483447151866, 3676.0149519259567, 3792.184680293736, 3920.5687374388795, 3932.6067393260732, 3956.9208615827665, 3730.5709843367954, 3883.7087218458587, 3895.8831235062994, 3902.765834049952, 3929.3713005919058, 3247.5778148840736, 3896.6556537994347, 3898.3957486589625, 3902.3951287550476, 3906.667933225665, 2845.3882415280814, 3356.1945133167865, 3387.6449420231856, 3407.6592340765724, 3410.215650400397, 4757.500462451462, 4971.726555039471, 4973.030259099477, 5049.33371987247, 5109.9489005109845, 4074.8370065197355, 4272.782257056755, 4465.732056076646, 4476.261416866213, 4495.14592227479, 5405.432429594875, 5408.648437851566, 5423.566114710814, 5432.375276843174, 5435.374931882845, 3167.572377729023, 3216.5979252593424, 3568.6431356864364, 3721.832517536717, 3756.1548651553453, 4952.653314268003, 4971.663318240421, 5688.0, 5727.541796656257, 5759.481646651821, 3662.8351724172476, 3766.2090960898518, 3769.4345848122452, 3776.86780962665, 3782.791946442917, 3282.163048422637, 3827.25368553135, 3835.961640383616, 3853.7109716771356, 3864.53625564934, 3774.9433758493647, 4345.591280871524, 4447.2439685253585, 4448.1095534397755, 4480.118350292885, 5016.0, 5356.437574054746, 5490.6431081979545, 5504.366997795225, 5513.724313784295, 1135.920875168593, 1207.7644859252537, 1217.5190799634272, 1246.0343233993547, 1268.543324403214, 748.1732685382683, 814.3810703864987, 850.9489430634181, 899.536738579632, 906.3836591117971, 3888.591697871739, 3985.8206380712936, 4549.45406551216, 4589.059242855206, 4793.161196790547, 4617.8383756568355, 4892.633052521075, 5102.489751024942, 5302.231176479466, 5335.279737235423, 4338.891527711832, 4560.566746159109, 4807.495213002654, 4820.480549770493, 4855.417349918032, 2368.526294741059, 2544.0, 2684.691260505028, 2733.7676297514936, 2790.734880186379, 5033.866615361143, 5300.4486993713535, 5355.544778693855, 5447.455254474521, 5460.235567020621, 5372.07222063976, 5397.3523177218985, 5426.620136590401, 5432.674039557639, 5438.7280635968045, 4941.50584941503, 5241.292425522582, 5442.836714898559, 5443.42844001382, 5457.890842183134, 4259.914801704011, 5060.709519072613, 5218.686878787133, 5282.81510147143, 5296.311479507639, 4962.925556116589, 5196.402413722471, 5211.71335576547, 5217.50433708797, 5223.399309079505, 4546.659000574904, 4652.441706995182, 5316.867078323073, 5450.184870590523, 5470.316210473691, 3305.124142102297, 3502.3695734767985, 3604.2971620533744, 3651.101427257864, 3662.633736626316, 4712.905741885074, 5088.54203121706, 5257.7371131442505, 5259.947400526099, 5267.813857249352, 4471.217536930959, 4570.9943812361225, 4902.240152776325, 5046.621503387188, 5091.923621145612, 4484.75333856628, 4492.775361231991, 4719.513353293702, 4899.902001960012, 5095.464976177596, 5005.7997680092385, 5061.342025536656, 5140.845774626767, 5268.446813084724, 5295.76169072385, 5109.835484080462, 5244.265802787689, 5461.808836690697, 5489.65503451641, 5496.917546236729, 4518.367428559938, 4966.553010229097, 5344.625876188629, 5385.9192112119135, 5394.462578165204], "value": 3864.7909315287266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7768080735377, 742.5396254322318, 748.3788455581868, 748.9550626962387, 769.8575763483758, 14912.403503859847, 16441.013539187657, 16452.670946581093, 16483.34066637333, 16503.422380216696, 14665.92667036666, 14744.189069601194, 14757.631059223524, 14811.333489992949, 14813.333399996998, 647.5855452510397, 666.6999850067489, 802.4984384759525, 825.8183199696057, 830.7715378270964, 801.6713147609481, 813.3737022492677, 824.4187847567481, 828.1015098618007, 828.8756686497013, 865.6364326982682, 865.7489328094845, 867.4274978514181, 869.0961400143843, 869.1048220333067, 671.9160104986877, 859.6862145316945, 861.2421069458899, 861.67687117331, 861.8664107063415, 512.4670342843439, 616.2635650397776, 632.2349956552576, 633.3191818794814, 636.0681601453846, 14029.158250505003, 14070.71858562823, 14071.437142514287, 14072.0, 14085.577432677037, 10053.246006549538, 12692.619221423372, 12929.806052909214, 12976.789321503578, 13334.799978000337, 11115.499802508826, 11255.212135150543, 11533.76932461346, 11728.824067638992, 11791.882081179165, 3547.113221694576, 3592.7125829933802, 3635.8182090895616, 3768.2651882882847, 3827.7129215308964, 79036.60481697612, 79716.60141699313, 82604.17395826086, 85064.99999999937, 85413.0, 9952.502374881227, 10011.462370179934, 10448.42533660656, 10480.423576703355, 10571.577136914591, 19731.50671233202, 19970.801751894935, 19998.600027999357, 20001.59996800056, 20005.499862503264, 7255.673494692646, 7323.304286092813, 7336.229695881855, 7667.539947603162, 7697.499662521918, 4107.835686572504, 4208.22147902639, 4223.1975924574235, 4273.1240095780295, 4410.845620403271, 3376.122208225879, 3439.9828000860334, 3441.4321636930126, 3473.3574288756663, 3509.9122521937156, 618.5051958433236, 628.7704987679556, 630.713025573363, 631.1479502671357, 645.4416929356167, 568.3918207517999, 606.5147881694627, 663.4294506724214, 674.2818897873749, 677.3632785181914, 8357.707480238163, 8845.557722113868, 8997.775055623531, 9004.774880628036, 9217.216536594331, 616.8434185901435, 634.8317695810614, 665.1951139121717, 670.8121725916751, 680.5134328954821, 4398.538153493837, 4447.688661793643, 4450.755208463501, 4456.77716114193, 4483.125790470827, 75570.24429755632, 114564.42717786525, 115897.0, 116132.0, 119875.0, 67937.98093028608, 77794.61102694564, 78097.60951195321, 97198.51400743093, 101828.98171018195, 73496.0, 86555.0, 87770.24459510646, 88096.11903880879, 90541.5472922618, 8799.604017819342, 8811.33914956368, 8818.38271321027, 8833.0, 8887.377883548348, 55817.44182558123, 56060.719696401255, 57159.14261286001, 58847.70576147092, 59064.0, 75491.49017019739, 77136.0, 77316.0, 77694.611526942, 79880.0, 11049.447527623748, 11124.555017799197, 11252.606158784403, 11272.098232141572, 11561.017313528107, 12026.879731202926, 12036.939815300868, 12340.50637974471, 12605.87394126047, 12829.871701282867, 11847.822282665938, 11895.76208475843, 12255.571055013032, 12365.938170309451, 12380.442880070239, 11779.528818847493, 11915.76168476643, 12004.519819207135, 12382.380880956096, 12399.132060756021, 11268.492917818881, 11353.03499202544, 11529.308241505536, 11867.821982670093, 11923.582674606347, 9752.171065459515, 9883.456409897524, 10191.94904025475, 10326.432046237529, 10380.688579342632, 9637.855432168382, 10181.134603558781, 10237.539310730886, 10239.7440063999, 10314.638987635397], "value": 7127.168609101091, "unit": "score"}], "name": "dromaeo_css", "value": 7123.361865474166, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 115.0, 115.0, 117.0, 114.0, 116.0, 114.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 111.0, 140.0, 112.0, 111.0, 105.0, 111.0, 142.0, 109.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 165.0, 251.0, 255.0, 199.0, 185.0, 185.0, 185.0, 185.0], "value": 197.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 88.0, 72.0, 59.0, 58.0, 59.0, 82.0, 58.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 94.0, 69.0, 68.0, 70.0, 89.0, 67.0, 68.0, 94.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 85.0, 87.0, 84.0, 87.0, 84.0, 85.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 79.0, 79.0, 84.0, 81.0, 82.0, 86.0, 81.0, 84.0], "value": 82.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 53.0, 54.0, 54.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 80.0, 73.0, 73.0, 69.0, 70.0, 69.0, 74.0, 69.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 96.0, 99.0, 87.0, 86.0, 98.0, 100.0, 99.0, 100.0, 88.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 145.0, 145.0, 146.0, 151.0, 146.0, 150.0, 215.0, 168.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 169.0, 167.0, 166.0, 184.0, 217.0, 202.0, 167.0, 170.0, 166.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 76.0, 84.0, 85.0, 83.0, 70.0, 66.0, 65.0, 67.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1470.1, "alertThreshold": 2.0}]} 12:05:34 INFO - Return code: 0 12:05:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:05:34 ERROR - # TBPL SUCCESS # 12:05:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:05:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:05:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:05:34 INFO - 2016-11-14 12:05:34.923 screenresolution[1662:9911] starting screenresolution argv=screenresolution get 12:05:34 INFO - 2016-11-14 12:05:34.925 screenresolution[1662:9911] Display 0: 1600x1200x32@60 12:05:34 INFO - 2016-11-14 12:05:34.932 screenresolution[1663:9914] starting screenresolution argv=screenresolution list 12:05:34 INFO - Available Modes on Display 0 12:05:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:05:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:05:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:05:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:05:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:05:35 INFO - Intel Iris: 12:05:35 INFO - Chipset Model: Intel Iris 12:05:35 INFO - Type: GPU 12:05:35 INFO - Bus: Built-In 12:05:35 INFO - VRAM (Dynamic, Max): 1536 MB 12:05:35 INFO - Vendor: Intel (0x8086) 12:05:35 INFO - Device ID: 0x0a2e 12:05:35 INFO - Revision ID: 0x0009 12:05:35 INFO - Displays: 12:05:35 INFO - Display: 12:05:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:05:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:05:35 INFO - Display Serial Number: 1600x1200 60 12:05:35 INFO - Main Display: Yes 12:05:35 INFO - Mirror: Off 12:05:35 INFO - Online: Yes 12:05:35 INFO - Rotation: Supported 12:05:35 INFO - Return code: 0 12:05:35 INFO - Running post-action listener: _resource_record_post_action 12:05:35 INFO - [mozharness: 2016-11-14 20:05:35.173593Z] Finished run-tests step (success) 12:05:35 INFO - Running post-run listener: _resource_record_post_run 12:05:35 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38265856; Write bytes: 651992576; Read time: 378; Write time: 1967 12:05:35 INFO - TinderboxPrint: CPU usage
53.6% 12:05:35 INFO - TinderboxPrint: I/O read bytes / time
38,265,856 / 378 12:05:35 INFO - TinderboxPrint: I/O write bytes / time
651,992,576 / 1,967 12:05:35 INFO - TinderboxPrint: CPU idle
2,248.9 (46.4%) 12:05:35 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 12:05:35 INFO - TinderboxPrint: CPU user
1,631.7 (33.6%) 12:05:35 INFO - TinderboxPrint: Swap in / out
391,467,008 / 0 12:05:35 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 341008896; Write bytes: 335967744; Read time: 26407; Write time: 727 12:05:35 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37299200; Write bytes: 295360512; Read time: 360; Write time: 1183 12:05:35 INFO - Running post-run listener: _upload_blobber_files 12:05:35 INFO - Blob upload gear active. 12:05:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:05:35 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 12:05:35 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'] 12:05:35 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 12:05:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:36 INFO - (blobuploader) - INFO - Done attempting. 12:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:37 INFO - (blobuploader) - INFO - Done attempting. 12:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:41 INFO - (blobuploader) - INFO - Done attempting. 12:05:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:05:41 INFO - Return code: 0 12:05:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:05:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:05:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef92d717bf2e045e541c5b0b64533f71163cc7ceaa0a3c015b693505bb7dea8b213d9d2c773c249c533a5bd390206eec90f6c6440cb75b8bac4d9809caee0758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/811fcad0b3b12a8cb4ef4e8b67ecd68fff4aad59c4ee20373cb3b54696a6fc97f9b71804729667ea18c9046beee9f95812b6a88e1c04712cc14645627dcff54a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac5a429192860d22a3884552dfc44a6a3124367532e829a9acce0b90a75b2e633c85e0d0f446a79f95d1c51c28050bc482a9bc4ae7226fc1bf531c9a5fd2480"} 12:05:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:05:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:05:41 INFO - Contents: 12:05:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef92d717bf2e045e541c5b0b64533f71163cc7ceaa0a3c015b693505bb7dea8b213d9d2c773c249c533a5bd390206eec90f6c6440cb75b8bac4d9809caee0758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/811fcad0b3b12a8cb4ef4e8b67ecd68fff4aad59c4ee20373cb3b54696a6fc97f9b71804729667ea18c9046beee9f95812b6a88e1c04712cc14645627dcff54a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac5a429192860d22a3884552dfc44a6a3124367532e829a9acce0b90a75b2e633c85e0d0f446a79f95d1c51c28050bc482a9bc4ae7226fc1bf531c9a5fd2480"} 12:05:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:05:41 INFO - Copying logs to upload dir... 12:05:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:05:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.333170 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-14 12:05:41.149629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:41.153050) ========= 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.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/ef92d717bf2e045e541c5b0b64533f71163cc7ceaa0a3c015b693505bb7dea8b213d9d2c773c249c533a5bd390206eec90f6c6440cb75b8bac4d9809caee0758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/811fcad0b3b12a8cb4ef4e8b67ecd68fff4aad59c4ee20373cb3b54696a6fc97f9b71804729667ea18c9046beee9f95812b6a88e1c04712cc14645627dcff54a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac5a429192860d22a3884552dfc44a6a3124367532e829a9acce0b90a75b2e633c85e0d0f446a79f95d1c51c28050bc482a9bc4ae7226fc1bf531c9a5fd2480"} build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010957 build_url: 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/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/ef92d717bf2e045e541c5b0b64533f71163cc7ceaa0a3c015b693505bb7dea8b213d9d2c773c249c533a5bd390206eec90f6c6440cb75b8bac4d9809caee0758", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/811fcad0b3b12a8cb4ef4e8b67ecd68fff4aad59c4ee20373cb3b54696a6fc97f9b71804729667ea18c9046beee9f95812b6a88e1c04712cc14645627dcff54a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ac5a429192860d22a3884552dfc44a6a3124367532e829a9acce0b90a75b2e633c85e0d0f446a79f95d1c51c28050bc482a9bc4ae7226fc1bf531c9a5fd2480"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:41.186321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:41.186669) ========= 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.vMsRHOnw62/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.wIHalFmTsd/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005118 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:41.235438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:05:41.235764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:05:41.236093) ========= ========= Total master_lag: 0.17 =========