builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0306 starttime: 1468502835.01 results: success (0) buildid: 20160714050942 builduid: c397ffc3b333402787154f3bf98d9259 revision: 306382512096564f06aa175ddddeef59a90f36f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.007501) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.008078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.008361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.034284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.034703) ========= 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.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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-07-14 06:27:15-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-07-14 06:27:15 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.225104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.225418) ========= 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.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.026297 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:15.276579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:27:15.277130) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 306382512096564f06aa175ddddeef59a90f36f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 306382512096564f06aa175ddddeef59a90f36f0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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-07-14 06:27:15,361 truncating revision to first 12 chars 2016-07-14 06:27:15,361 Setting DEBUG logging. 2016-07-14 06:27:15,361 attempt 1/10 2016-07-14 06:27:15,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/306382512096?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:27:16,896 unpacking tar archive at: mozilla-beta-306382512096/testing/mozharness/ program finished with exit code 0 elapsedTime=1.815605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:27:17.115069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:17.115399) ========= script_repo_revision: 306382512096564f06aa175ddddeef59a90f36f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:17.115786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:17.116089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:27:17.133947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-14 06:27:17.134314) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:17 INFO - MultiFileLogger online at 20160714 06:27:17 in /builds/slave/test 06:27:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:17 INFO - {'append_to_log': False, 06:27:17 INFO - 'base_work_dir': '/builds/slave/test', 06:27:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:17 INFO - 'branch': 'Mozilla-Beta', 06:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:17 INFO - 'config_files': ('talos/mac_config.py',), 06:27:17 INFO - 'default_actions': ('clobber', 06:27:17 INFO - 'read-buildbot-config', 06:27:17 INFO - 'download-and-extract', 06:27:17 INFO - 'populate-webroot', 06:27:17 INFO - 'create-virtualenv', 06:27:17 INFO - 'install', 06:27:17 INFO - 'run-tests'), 06:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:17 INFO - 'download_minidump_stackwalk': True, 06:27:17 INFO - 'download_symbols': 'ondemand', 06:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:17 INFO - 'installer_path': 'installer.exe', 06:27:17 INFO - 'log_level': 'info', 06:27:17 INFO - 'log_name': 'talos', 06:27:17 INFO - 'log_to_console': True, 06:27:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:27:17 INFO - 'opt_config_files': (), 06:27:17 INFO - 'pip_index': False, 06:27:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:27:17 INFO - 'cmd': ('bash', 06:27:17 INFO - '-c', 06:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:27:17 INFO - 'enabled': True, 06:27:17 INFO - 'halt_on_failure': False, 06:27:17 INFO - 'name': 'check_screen_resolution'},), 06:27:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:27:17 INFO - 'cmd': ('bash', 06:27:17 INFO - '-c', 06:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:27:17 INFO - 'enabled': True, 06:27:17 INFO - 'halt_on_failure': False, 06:27:17 INFO - 'name': 'check_screen_resolution'},), 06:27:17 INFO - 'run_cmd_checks_enabled': True, 06:27:17 INFO - 'sps_profile': False, 06:27:17 INFO - 'sps_profile_interval': 0, 06:27:17 INFO - 'suite': 'dromaeojs', 06:27:17 INFO - 'system_bits': '32', 06:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:17 INFO - 'title': 't-yosemite-r7-0306', 06:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:17 INFO - 'use_talos_json': True, 06:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:17 INFO - 'work_dir': 'build'} 06:27:17 INFO - ##### 06:27:17 INFO - ##### Running clobber step. 06:27:17 INFO - ##### 06:27:17 INFO - Running pre-action listener: _resource_record_pre_action 06:27:17 INFO - Running main action method: clobber 06:27:17 INFO - rmtree: /builds/slave/test/build 06:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:19 INFO - Running post-action listener: _resource_record_post_action 06:27:19 INFO - ##### 06:27:19 INFO - ##### Running read-buildbot-config step. 06:27:19 INFO - ##### 06:27:19 INFO - Running pre-action listener: _resource_record_pre_action 06:27:19 INFO - Running main action method: read_buildbot_config 06:27:19 INFO - Using buildbot properties: 06:27:19 INFO - { 06:27:19 INFO - "project": "", 06:27:19 INFO - "product": "firefox", 06:27:19 INFO - "script_repo_revision": "production", 06:27:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:27:19 INFO - "repository": "", 06:27:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:27:19 INFO - "buildid": "20160714050942", 06:27:19 INFO - "pgo_build": "False", 06:27:19 INFO - "basedir": "/builds/slave/test", 06:27:19 INFO - "buildnumber": 35, 06:27:19 INFO - "slavename": "t-yosemite-r7-0306", 06:27:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:27:19 INFO - "platform": "yosemite_r7", 06:27:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:27:19 INFO - "branch": "mozilla-beta", 06:27:19 INFO - "repo_path": "releases/mozilla-beta", 06:27:19 INFO - "revision": "306382512096564f06aa175ddddeef59a90f36f0", 06:27:19 INFO - "stage_platform": "macosx64", 06:27:19 INFO - "builduid": "c397ffc3b333402787154f3bf98d9259", 06:27:19 INFO - "slavebuilddir": "test" 06:27:19 INFO - } 06:27:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 06:27:19 INFO - Running post-action listener: _resource_record_post_action 06:27:19 INFO - ##### 06:27:19 INFO - ##### Running download-and-extract step. 06:27:19 INFO - ##### 06:27:19 INFO - Running pre-action listener: _resource_record_pre_action 06:27:19 INFO - Running main action method: download_and_extract 06:27:19 INFO - mkdir: /builds/slave/test/build/tests 06:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:19 INFO - https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 06:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 06:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 06:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 06:27:20 INFO - Downloaded 1165 bytes. 06:27:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 06:27:20 INFO - Using the following test package requirements: 06:27:20 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 06:27:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 06:27:20 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 06:27:20 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:27:20 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 06:27:20 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 06:27:20 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 06:27:20 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 06:27:20 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 06:27:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 06:27:20 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 06:27:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 06:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:20 INFO - https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 06:27:21 INFO - Downloaded 18314862 bytes. 06:27:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:24 INFO - Return code: 0 06:27:24 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:27:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:24 INFO - https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 06:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 06:27:25 INFO - Downloaded 18314862 bytes. 06:27:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:29 INFO - Return code: 0 06:27:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:29 INFO - https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 06:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 06:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 06:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 06:27:30 INFO - Downloaded 10840145 bytes. 06:27:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:27:31 INFO - Return code: 0 06:27:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:31 INFO - https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 06:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 06:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 06:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 06:27:33 INFO - Downloaded 86190410 bytes. 06:27:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 06:27:33 INFO - mkdir: /builds/slave/test/properties 06:27:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:33 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:33 INFO - Contents: 06:27:33 INFO - build_url:https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 06:27:34 INFO - Running post-action listener: _resource_record_post_action 06:27:34 INFO - Running post-action listener: set_extra_try_arguments 06:27:34 INFO - ##### 06:27:34 INFO - ##### Running populate-webroot step. 06:27:34 INFO - ##### 06:27:34 INFO - Running pre-action listener: _resource_record_pre_action 06:27:34 INFO - Running main action method: populate_webroot 06:27:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:34 INFO - '--tppagecycles', 06:27:34 INFO - '7'], 06:27:34 INFO - 'tests': ['tsvgm']}}, 06:27:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:27:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:27:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['damp', 'tps']}, 06:27:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'tests': ['damp', 'tps']}, 06:27:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['dromaeo_dom']}, 06:27:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'other-e10s': {'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['a11yr', 06:27:34 INFO - 'ts_paint', 06:27:34 INFO - 'tpaint', 06:27:34 INFO - 'sessionrestore', 06:27:34 INFO - 'sessionrestore_no_auto_restore', 06:27:34 INFO - 'tabpaint']}, 06:27:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['tsvgx', 06:27:34 INFO - 'tsvgr_opacity', 06:27:34 INFO - 'tart', 06:27:34 INFO - 'tscrollx', 06:27:34 INFO - 'cart']}, 06:27:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:27:34 INFO - 'tsvgr_opacity', 06:27:34 INFO - 'tart', 06:27:34 INFO - 'tscrollx', 06:27:34 INFO - 'cart']}, 06:27:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'talos_options': ['--disable-e10s'], 06:27:34 INFO - 'tests': ['tp5o']}, 06:27:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'tests': ['tp5o']}, 06:27:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'talos_options': ['--disable-e10s', 06:27:34 INFO - '--xperf_path', 06:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:34 INFO - 'tests': ['tp5n']}, 06:27:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:34 INFO - 'talos_options': ['--xperf_path', 06:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:34 INFO - 'tests': ['tp5n']}}, 06:27:34 INFO - 'talos.zip': {'path': '', 06:27:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:34 INFO - Running post-action listener: _resource_record_post_action 06:27:34 INFO - ##### 06:27:34 INFO - ##### Running create-virtualenv step. 06:27:34 INFO - ##### 06:27:34 INFO - Running pre-action listener: _resource_record_pre_action 06:27:34 INFO - Running main action method: create_virtualenv 06:27:34 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:34 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 06:27:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:34 INFO - Using real prefix '/tools/python27' 06:27:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:35 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:38 INFO - Installing pip.................done. 06:27:38 INFO - Return code: 0 06:27:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:38 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:38 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 06:27:38 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 06:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:38 INFO - 'HOME': '/Users/cltbld', 06:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:38 INFO - 'LOGNAME': 'cltbld', 06:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:38 INFO - 'MOZ_NO_REMOTE': '1', 06:27:38 INFO - 'NO_EM_RESTART': '1', 06:27:38 INFO - 'PAGER': '/bin/cat', 06:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:38 INFO - 'PWD': '/builds/slave/test', 06:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:38 INFO - 'SHELL': '/bin/bash', 06:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:38 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:38 INFO - 'USER': 'cltbld', 06:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:38 INFO - 'XPC_FLAGS': '0x0', 06:27:38 INFO - 'XPC_SERVICE_NAME': '0', 06:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:38 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 06:27:38 INFO - Cleaning up... 06:27:38 INFO - Return code: 0 06:27:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:27:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:38 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:38 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>=0.7.1'] in /builds/slave/test/build 06:27:38 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>=0.7.1 06:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:38 INFO - 'HOME': '/Users/cltbld', 06:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:38 INFO - 'LOGNAME': 'cltbld', 06:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:38 INFO - 'MOZ_NO_REMOTE': '1', 06:27:38 INFO - 'NO_EM_RESTART': '1', 06:27:38 INFO - 'PAGER': '/bin/cat', 06:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:38 INFO - 'PWD': '/builds/slave/test', 06:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:38 INFO - 'SHELL': '/bin/bash', 06:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:38 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:38 INFO - 'USER': 'cltbld', 06:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:38 INFO - 'XPC_FLAGS': '0x0', 06:27:38 INFO - 'XPC_SERVICE_NAME': '0', 06:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:38 INFO - Downloading/unpacking psutil>=0.7.1 06:27:38 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 06:27:38 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 06:27:38 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 06:27:38 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 06:27:38 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 06:27:38 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 06:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:41 INFO - Installing collected packages: psutil 06:27:41 INFO - Running setup.py install for psutil 06:27:41 INFO - building 'psutil._psutil_osx' extension 06:27:41 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 06:27:42 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 06:27:42 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 06:27:42 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 06:27:42 INFO - building 'psutil._psutil_posix' extension 06:27:42 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 06:27:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:27:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:27:42 INFO - ^ 06:27:42 INFO - 1 warning generated. 06:27:42 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 06:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:42 INFO - Successfully installed psutil 06:27:42 INFO - Cleaning up... 06:27:42 INFO - Return code: 0 06:27:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:42 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.0.0'] in /builds/slave/test/build 06:27:42 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.0.0 06:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:42 INFO - 'HOME': '/Users/cltbld', 06:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:42 INFO - 'LOGNAME': 'cltbld', 06:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:42 INFO - 'MOZ_NO_REMOTE': '1', 06:27:42 INFO - 'NO_EM_RESTART': '1', 06:27:42 INFO - 'PAGER': '/bin/cat', 06:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:42 INFO - 'PWD': '/builds/slave/test', 06:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:42 INFO - 'SHELL': '/bin/bash', 06:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:42 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:42 INFO - 'USER': 'cltbld', 06:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:42 INFO - 'XPC_FLAGS': '0x0', 06:27:42 INFO - 'XPC_SERVICE_NAME': '0', 06:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:27:42 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 06:27:42 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 06:27:42 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 06:27:42 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 06:27:42 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 06:27:42 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 06:27:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:27:45 INFO - Installing collected packages: mozsystemmonitor 06:27:45 INFO - Running setup.py install for mozsystemmonitor 06:27:45 INFO - Successfully installed mozsystemmonitor 06:27:45 INFO - Cleaning up... 06:27:45 INFO - Return code: 0 06:27:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:45 INFO - 'HOME': '/Users/cltbld', 06:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:45 INFO - 'LOGNAME': 'cltbld', 06:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:45 INFO - 'MOZ_NO_REMOTE': '1', 06:27:45 INFO - 'NO_EM_RESTART': '1', 06:27:45 INFO - 'PAGER': '/bin/cat', 06:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:45 INFO - 'PWD': '/builds/slave/test', 06:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:45 INFO - 'SHELL': '/bin/bash', 06:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:45 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:45 INFO - 'USER': 'cltbld', 06:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:45 INFO - 'XPC_FLAGS': '0x0', 06:27:45 INFO - 'XPC_SERVICE_NAME': '0', 06:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:48 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 06:27:48 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 06:27:48 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 06:27:48 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 06:27:48 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 06:27:48 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 06:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:49 INFO - Downloading docopt-0.6.1.tar.gz 06:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:49 INFO - Running setup.py install for blobuploader 06:27:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:49 INFO - Running setup.py install for requests 06:27:50 INFO - Running setup.py install for docopt 06:27:50 INFO - Successfully installed blobuploader requests docopt 06:27:50 INFO - Cleaning up... 06:27:50 INFO - Return code: 0 06:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:50 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 06:27:50 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 06:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:50 INFO - 'HOME': '/Users/cltbld', 06:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:50 INFO - 'LOGNAME': 'cltbld', 06:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:50 INFO - 'MOZ_NO_REMOTE': '1', 06:27:50 INFO - 'NO_EM_RESTART': '1', 06:27:50 INFO - 'PAGER': '/bin/cat', 06:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:50 INFO - 'PWD': '/builds/slave/test', 06:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:50 INFO - 'SHELL': '/bin/bash', 06:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:50 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:50 INFO - 'USER': 'cltbld', 06:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:50 INFO - 'XPC_FLAGS': '0x0', 06:27:50 INFO - 'XPC_SERVICE_NAME': '0', 06:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:50 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-hXALxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:50 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6bfKuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:50 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xj0kA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-CIEk5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Q6x1VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-wjSPNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Wt8NLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-31xM7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-XP3o1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-UqgiPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-qeGrES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:51 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-I5ssgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-2NSfmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-C0wjrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-7L5VyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-3bbKbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:52 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-2TmwO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:52 INFO - Running setup.py install for manifestparser 06:27:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:52 INFO - Running setup.py install for mozcrash 06:27:52 INFO - Running setup.py install for mozdebug 06:27:52 INFO - Running setup.py install for mozdevice 06:27:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Running setup.py install for mozfile 06:27:53 INFO - Running setup.py install for mozhttpd 06:27:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Running setup.py install for mozinfo 06:27:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Running setup.py install for mozInstall 06:27:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:53 INFO - Running setup.py install for mozleak 06:27:53 INFO - Running setup.py install for mozlog 06:27:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Running setup.py install for moznetwork 06:27:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Running setup.py install for mozprocess 06:27:54 INFO - Running setup.py install for mozprofile 06:27:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Running setup.py install for mozrunner 06:27:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:54 INFO - Running setup.py install for mozscreenshot 06:27:54 INFO - Running setup.py install for moztest 06:27:54 INFO - Running setup.py install for mozversion 06:27:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:55 INFO - Cleaning up... 06:27:55 INFO - Return code: 0 06:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:27:55 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 06:27:55 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 06:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:55 INFO - 'HOME': '/Users/cltbld', 06:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:55 INFO - 'LOGNAME': 'cltbld', 06:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:55 INFO - 'MOZ_NO_REMOTE': '1', 06:27:55 INFO - 'NO_EM_RESTART': '1', 06:27:55 INFO - 'PAGER': '/bin/cat', 06:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:55 INFO - 'PWD': '/builds/slave/test', 06:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:55 INFO - 'SHELL': '/bin/bash', 06:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:27:55 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:55 INFO - 'USER': 'cltbld', 06:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:55 INFO - 'XPC_FLAGS': '0x0', 06:27:55 INFO - 'XPC_SERVICE_NAME': '0', 06:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-rA6U0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:55 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)) 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_B2Pp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-YhIX50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:55 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)) 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ANGV_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:55 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)) 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-pjE6d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:55 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)) 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:55 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-mwrR5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-4efgTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-7CjPGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ZPN5nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-6q0dvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_2ymd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-FLbS47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-MS7L76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-EOJSfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ObpQiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:56 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)) 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:56 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-i519IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:57 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)) 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:57 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_Xpyy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:57 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)) 06:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:57 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)) 06:27:57 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)) 06:27:57 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)) 06:27:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:59 INFO - Downloading blessings-1.6.tar.gz 06:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:59 INFO - Installing collected packages: blessings 06:27:59 INFO - Running setup.py install for blessings 06:27:59 INFO - Successfully installed blessings 06:27:59 INFO - Cleaning up... 06:27:59 INFO - Return code: 0 06:27:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:00 INFO - Reading from file tmpfile_stdout 06:28:00 INFO - Current package versions: 06:28:00 INFO - blessings == 1.6 06:28:00 INFO - blobuploader == 1.2.4 06:28:00 INFO - docopt == 0.6.1 06:28:00 INFO - manifestparser == 1.1 06:28:00 INFO - mozInstall == 1.12 06:28:00 INFO - mozcrash == 0.17 06:28:00 INFO - mozdebug == 0.1 06:28:00 INFO - mozdevice == 0.48 06:28:00 INFO - mozfile == 1.2 06:28:00 INFO - mozhttpd == 0.7 06:28:00 INFO - mozinfo == 0.9 06:28:00 INFO - mozleak == 0.1 06:28:00 INFO - mozlog == 3.1 06:28:00 INFO - moznetwork == 0.27 06:28:00 INFO - mozprocess == 0.22 06:28:00 INFO - mozprofile == 0.28 06:28:00 INFO - mozrunner == 6.11 06:28:00 INFO - mozscreenshot == 0.1 06:28:00 INFO - mozsystemmonitor == 0.0 06:28:00 INFO - moztest == 0.7 06:28:00 INFO - mozversion == 1.4 06:28:00 INFO - psutil == 3.1.1 06:28:00 INFO - requests == 1.2.3 06:28:00 INFO - wsgiref == 0.1.2 06:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:00 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:28:00 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 06:28:00 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 06:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:00 INFO - 'HOME': '/Users/cltbld', 06:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:00 INFO - 'LOGNAME': 'cltbld', 06:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:00 INFO - 'MOZ_NO_REMOTE': '1', 06:28:00 INFO - 'NO_EM_RESTART': '1', 06:28:00 INFO - 'PAGER': '/bin/cat', 06:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:00 INFO - 'PWD': '/builds/slave/test', 06:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:00 INFO - 'SHELL': '/bin/bash', 06:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:28:00 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:00 INFO - 'USER': 'cltbld', 06:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:00 INFO - 'XPC_FLAGS': '0x0', 06:28:00 INFO - 'XPC_SERVICE_NAME': '0', 06:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 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)) 06:28:00 INFO - Cleaning up... 06:28:00 INFO - Return code: 0 06:28:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:00 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:28:00 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 06:28:00 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 06:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:00 INFO - 'HOME': '/Users/cltbld', 06:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:00 INFO - 'LOGNAME': 'cltbld', 06:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:00 INFO - 'MOZ_NO_REMOTE': '1', 06:28:00 INFO - 'NO_EM_RESTART': '1', 06:28:00 INFO - 'PAGER': '/bin/cat', 06:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:00 INFO - 'PWD': '/builds/slave/test', 06:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:00 INFO - 'SHELL': '/bin/bash', 06:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:28:00 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:00 INFO - 'USER': 'cltbld', 06:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:00 INFO - 'XPC_FLAGS': '0x0', 06:28:00 INFO - 'XPC_SERVICE_NAME': '0', 06:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:00 INFO - Downloading/unpacking jsonschema 06:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:03 INFO - Downloading/unpacking functools32 (from jsonschema) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:03 INFO - warning: no files found matching '*.txt' 06:28:03 INFO - no previously-included directories found matching 'build' 06:28:03 INFO - no previously-included directories found matching 'dist' 06:28:03 INFO - no previously-included directories found matching '.git*' 06:28:03 INFO - Installing collected packages: jsonschema, functools32 06:28:03 INFO - Running setup.py install for functools32 06:28:03 INFO - warning: no files found matching '*.txt' 06:28:03 INFO - no previously-included directories found matching 'build' 06:28:03 INFO - no previously-included directories found matching 'dist' 06:28:03 INFO - no previously-included directories found matching '.git*' 06:28:03 INFO - Successfully installed jsonschema functools32 06:28:03 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa63d96510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.reaMUMWi3K/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.38iJRoAdl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 06:28: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', 'flake8'] in /builds/slave/test/build 06:28: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 flake8 06:28:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:28:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:04 INFO - 'HOME': '/Users/cltbld', 06:28:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PAGER': '/bin/cat', 06:28:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:28:04 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:28:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - 'XPC_FLAGS': '0x0', 06:28:04 INFO - 'XPC_SERVICE_NAME': '0', 06:28:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 INFO - Downloading/unpacking flake8 06:28:04 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 06:28:04 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 06:28:04 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 06:28:04 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 06:28:04 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 06:28:04 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 06:28:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:07 INFO - no previously-included directories found matching 'docs/_build' 06:28:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:08 INFO - Running setup.py install for pep8 06:28:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:08 INFO - no previously-included directories found matching 'docs/_build' 06:28:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:08 INFO - Cleaning up... 06:28:08 INFO - Return code: 0 06:28:08 INFO - Running post-action listener: _resource_record_post_action 06:28:08 INFO - Running post-action listener: _start_resource_monitoring 06:28:08 INFO - Starting resource monitoring. 06:28:08 INFO - ##### 06:28:08 INFO - ##### Running install step. 06:28:08 INFO - ##### 06:28:08 INFO - Running pre-action listener: _resource_record_pre_action 06:28:08 INFO - Running main action method: install 06:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:08 INFO - Reading from file tmpfile_stdout 06:28:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:08 INFO - Reading from file tmpfile_stdout 06:28:08 INFO - Output received: 06:28:08 INFO - Usage: mozinstall [options] installer 06:28:08 INFO - Options: 06:28:08 INFO - -h, --help show this help message and exit 06:28:08 INFO - -d DEST, --destination=DEST 06:28:08 INFO - Directory to install application into. [default: 06:28:08 INFO - "/builds/slave/test"] 06:28:08 INFO - --app=APP Application being installed. [default: firefox] 06:28:08 INFO - mkdir: /builds/slave/test/build/application 06:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:28:30 INFO - Reading from file tmpfile_stdout 06:28:30 INFO - Output received: 06:28:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:28:30 INFO - Running post-action listener: _resource_record_post_action 06:28:30 INFO - ##### 06:28:30 INFO - ##### Running run-tests step. 06:28:30 INFO - ##### 06:28:30 INFO - Running pre-action listener: _resource_record_pre_action 06:28:30 INFO - Running main action method: run_tests 06:28:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:28:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:28:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:28:30 INFO - 2016-07-14 06:28:30.571 screenresolution[1638:7611] starting screenresolution argv=screenresolution get 06:28:30 INFO - 2016-07-14 06:28:30.573 screenresolution[1638:7611] Display 0: 1600x1200x32@60 06:28:30 INFO - 2016-07-14 06:28:30.579 screenresolution[1639:7614] starting screenresolution argv=screenresolution list 06:28:30 INFO - Available Modes on Display 0 06:28:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:28:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:28:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:28:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:28:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:28:30 INFO - Intel Iris: 06:28:30 INFO - Chipset Model: Intel Iris 06:28:30 INFO - Type: GPU 06:28:30 INFO - Bus: Built-In 06:28:30 INFO - VRAM (Dynamic, Max): 1536 MB 06:28:30 INFO - Vendor: Intel (0x8086) 06:28:30 INFO - Device ID: 0x0a2e 06:28:30 INFO - Revision ID: 0x0009 06:28:30 INFO - Displays: 06:28:30 INFO - Display: 06:28:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:28:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:28:30 INFO - Display Serial Number: 1600x1200 60 06:28:30 INFO - Main Display: Yes 06:28:30 INFO - Mirror: Off 06:28:30 INFO - Online: Yes 06:28:30 INFO - Rotation: Supported 06:28:30 INFO - Return code: 0 06:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:30 INFO - Python 2.7.3 06:28:30 INFO - Return code: 0 06:28:30 INFO - grabbing minidump binary from tooltool 06:28:30 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:30 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109ea2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:30 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 06:28:30 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 06:28:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:30 INFO - Return code: 0 06:28:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:28:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:28:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:32 INFO - Return code: 0 06:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 06:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 06:28:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reaMUMWi3K/Render', 06:28:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:32 INFO - 'HOME': '/Users/cltbld', 06:28:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:32 INFO - 'LOGNAME': 'cltbld', 06:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:32 INFO - 'MOZ_NO_REMOTE': '1', 06:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:32 INFO - 'NO_EM_RESTART': '1', 06:28:32 INFO - 'PAGER': '/bin/cat', 06:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:32 INFO - 'PWD': '/builds/slave/test', 06:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:32 INFO - 'SHELL': '/bin/bash', 06:28:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.38iJRoAdl2/Listeners', 06:28:32 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 06:28:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:32 INFO - 'USER': 'cltbld', 06:28:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:32 INFO - 'XPC_FLAGS': '0x0', 06:28:32 INFO - 'XPC_SERVICE_NAME': '0', 06:28:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 06:28:32 INFO - mozversion application_buildid: 20160714050942 06:28:32 INFO - mozversion application_changeset: 306382512096564f06aa175ddddeef59a90f36f0 06:28:32 INFO - mozversion application_display_name: Firefox 06:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:32 INFO - mozversion application_name: Firefox 06:28:32 INFO - mozversion application_remotingname: firefox 06:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:28:32 INFO - mozversion application_vendor: Mozilla 06:28:32 INFO - mozversion application_version: 48.0 06:28:32 INFO - mozversion platform_buildid: 20160714050942 06:28:32 INFO - mozversion platform_changeset: 306382512096564f06aa175ddddeef59a90f36f0 06:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:28:32 INFO - mozversion platform_version: 48.0 06:28:32 INFO - using testdate: 1468502912 06:28:32 INFO - actual date: 1468502912 06:28:32 INFO - starting webserver on 'localhost:49275' 06:28:32 INFO - SUITE-START | Running 2 tests 06:28:32 INFO - TEST-START | dromaeo_css 06:28:32 INFO - operating with platform_type : mac_ 06:28:32 INFO - Initialising browser for dromaeo_css test... 06:28:32 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpMoYeNa/profile http://localhost:49275/getInfo.html) 06:28:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 06:28:34 INFO - PROCESS | 1657 | colorDepth:24 06:28:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 06:28:34 INFO - PROCESS | 1657 | __metrics 06:28:34 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:28:34 ERROR - PROCESS | 1657 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:28:35 INFO - TEST-INFO | 1657: exit 0 06:28:35 INFO - Browser initialized. 06:28:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:35 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpMoYeNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:47 INFO - PROCESS | 1660 | RSS: Main: 160329728 06:28:47 INFO - PROCESS | 1660 | 06:29:38 INFO - PROCESS | 1660 | 1468502978352 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] 06:31:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:31:50 INFO - PROCESS | 1660 | RSS: Main: 289255424 06:31:50 INFO - PROCESS | 1660 | 06:34:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:34:53 INFO - PROCESS | 1660 | RSS: Main: 303153152 06:34:53 INFO - PROCESS | 1660 | 06:37:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 06:37:56 INFO - PROCESS | 1660 | RSS: Main: 310308864 06:37:56 INFO - PROCESS | 1660 | 06:40:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 06:40:58 INFO - PROCESS | 1660 | RSS: Main: 301604864 06:40:58 INFO - PROCESS | 1660 | 06:44:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 06:44:02 INFO - PROCESS | 1660 | RSS: Main: 274673664 06:44:02 INFO - PROCESS | 1660 | 06:47:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 06:47:05 INFO - PROCESS | 1660 | RSS: Main: 322686976 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | __start_tp_report 06:47:05 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:47:05 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:47:05 INFO - PROCESS | 1660 | |i|pagename|runs| 06:47:05 INFO - PROCESS | 1660 | |0;dojo.html;3610.909727256819;3632.219072899326;3654.214343916061;3656.469811877277;3704.851805927763;6076.483498902588;6094.26868775747;6102.420270074342;6108.328083910772;6122.510199184066;6085;6100.084987251915;6127.908081378783;6133.1413602095745;6135.110408990694;5400.648957817729;5459.890802183944;5499.890002199953;5513.50378465938;5580.107182850745;5497.422770609089;5561.694106824123;5563;5565.749541270632;5575.275214222145;5450.345958484968;5514.255575497296;5531.861703457425;5542.806001789938;5575.386707462176;5498.1752737089355;5535.58483113768;5560.77756889724;5563.499285064364;5574.219609254667;5373.838784836422;5376.327959005124;5463.2078348639225;5464.535514481274;5468.050832289264;5968.67172305523;6052.848678783022;6056.303525094627;6059.460319987303;6083.475357726583;6379.170707808002;6388.425041746265;6393.360663933616;6400.199975003125;6413.230412350548;6350.555461117724;6402.167718196652;6497.220333560003;6507.674616269168;6516.348365163493;6160.0759886017;6173.475254603364;6197.938020619827;6207.379262073847;6210.037444196202;6581.308962558958;6594.868102638016;6598.637074960827;6604.306547812506;6607.900881486781;5353.9196912046355;6215.098810672427;6291.811245662638;6357.777477788348;6367.395097465734;6478.190226221723;6483.740650374027;6486.545941784124;6490.318516555788;6510.609363438209;6313.43179113882;6363.777267795697;6377.075324078076;6389;6391.456726178234;6223.813285601439;6329.430351268408;6330.208723909512;6347.96826015867;6385.10608514799;5087.364079490064;5092.821751238689;5141.126008578551;5153;5164.122099243138;4603.240465323252;4605.976970115195;4607.193741095295;4613.8385156520035;4643.721376717408;6113.908291375633;6137.925862973962;6150.354212807681;6152.630842149485;6160.414760597736;6323.494120470351;6384.3934826191435;6395.904061439082;6478.481721462272;6485.6108633482145;5941.554383421174;6003.129546215774;6072.787452439144;6129.387061293835;6154.599951003171;5611.971940140274;5624.0439125348785;5635;5669.518090962232;5732.656040637575;6377.840553986095;6480.902786458301;6508.60948343101;6517.967410162919;6527.314631963671;6385.521085918667;6399.93600064012;6403.4877209824035;6405.423511883952;6600.60396376219;6635.502337324817;6635.535512514078;6639.900401494078;6642.302558231316;6652.201735791542;6216.316205217513;6292.590981586182;6355.014972679242;6369.426751592379;6383.808485745435;6315.179026726496;6393.392627700361;6407.775727849503;6409.327020662763;6412.422881940648;4916.926246106383;6287.937120628735;6304.022876454157;6308.400701933309;6312.242530896322;6229.1590635265475;6271.74913003493;6279.30927597973;6283.748650053946;6346.650934198478;4877.244027175793;5129.281900533853;5370.221317908803;6266.874662506815;6321.399467050623;6255.843603909939;6274.027525733519;6314.084457753692;6323.810285691437;6325.905111423241;6114.814446323713;6200.689965501797;6237;6243.375662433902;6277.529185311028 06:47:05 INFO - PROCESS | 1660 | |1;ext.html;517.2732311102901;518.7354449230891;574.0126981591666;584.4593750780529;612.2041346249877;30149.698503014963;32722.836385818067;37550.24899502012;38661.03347416309;38669.61330386695;43226;43445.78277108618;43457.78271108648;43596.564034359646;43626.563734362644;9634.759131021729;9858.901410985905;9859.753506162331;9860.013998600118;9863.30956833022;9232.8615070774;11757.353345566033;12008.519659213622;12026.639200823989;12031.51873925042;11743.823842642325;11851.703707407298;11860.110491713112;11882.28706277626;11908;11742.354170520617;11900.166988310822;11904.404779760976;11913.583024594183;11922.463489143009;11467.426628668532;11683.182177247596;11695.41522923859;11709.238899471507;11712.590059347967;41557.58442415568;41998;42061.78969105166;42077.57922420767;42450.57549424497;3252.1381833814057;3422.8801991930163;3661.5423072115987;3669.8165091745304;4001.9399709004388;28875.42249155026;29563.556546651816;29748.40503189924;29749;30010.420284821073;2820.2244382794897;2836.517791975369;2869.239651492356;2885.2354126156583;2888.508953477914;452962;542715.2864235693;542951.2852435752;545013;551911;37102.814485927396;61227.08159377613;61255.693721532;61740;61858.69070654708;36406;36558;36571.26857462889;36574.817125914204;36614.8169259152;16375.42686005984;16512.33950641961;16516.587085322964;16553.25510352037;16562.089085100193;12970.675733106558;13811.309434528433;13926.860731392557;14041.01712880109;14188.361523731457;8431.15688431152;8439.240468357877;8483.194096560817;8509.872351914726;8519.148085191555;3494.545709057806;3519.472079188091;3524.9823750881083;3535.116220944764;3554.928901422009;986.3440811860032;991.2020823237364;1031.1905154453718;1064.84559738839;1096.276457538021;28671.42657146887;30922.690773092432;31080.844595776878;31129.668979795973;31775.682243177736;1180.138498895811;1181.6750393641817;1211.733418647896;1234.2717796500108;1322.490841026212;15674.764878526832;15911;15960.840391596168;15966.680666386606;16309.918450407671;538032;640368;650357;656530;657680;63830.72338553296;64364.67817660882;64472.677636611515;64482;64512.032319515245;1389.9930500347637;1412.2797373339465;1536.6926614677109;1537.93079311429;1612.7338989066907;28323.150305490868;29192;29684.851575741985;30211.69788302089;30243.848780755954;48591.757041214565;48821.75589122032;48920.75539622279;48965.77585560247;49061.509384905694;367766;371243;371300;371435;372379;28255.576166357932;28345.007924722537;43677.908052298946;45684.543154568026;45814.54185458236;43141.784291078344;45065.77467112643;45133.64599062033;45183;45753.33973282196;37060.84982776494;37922.810385947894;38178.618213817506;38415.84752457431;39293.60706393014;37193.81403092967;38108;38204.04489887775;38545.6145438542;38906.8327950162;37539.62460375361;37655;38618.22763544769;38706.4194037084;38787;33143.33713325672;33759.72256626208;34143.317133657685;34207.48688769621;34269.828650857584;22512.986915589165;23345.299641010795;25575.488490230462;25681.22956311314;25764.96940122374 06:47:05 INFO - PROCESS | 1660 | |2;jquery.html;421.4121300785404;421.6015865007568;424.39523678757763;425.2069889655791;436.5263688897546;20200.494987625334;20481.59036819263;21058;21137.57724845502;21150.682739758915;17693.823061769377;20559.794402055973;21040.57918841626;21613.45966350842;21624.918754062273;5447.754851031703;5969.462748352647;5978.163057172;5984.431479009487;5993.760249590011;5829.883402331972;5966.343702192756;5974.4324289192455;5976.820695379146;5977.731002104916;5637.577181711367;5930.614510056854;5930.851728706773;5935.050391937291;5935.703214839263;5816.069428891378;5890.322612899486;5892.941070589325;5899.528037756991;5901.085331773604;5509.944900550983;5832.387599302097;5845.561582881301;5853.5902486825935;5857.384974577651;14020.369083391271;14091.859081409157;14354.64113397163;14387.496437624633;14539;2053.7330147080784;2140.9892950535304;2185.519185779126;2325.837191396603;2587.236765154284;9772.560234789451;10008.799824003552;10104.040116189024;10339.586416543329;10476.738081548023;1836.0904659154464;1853.184598776534;1856.693645548483;1887.631911777204;1942.5629233422508;66377;97638;104876.95123048748;114482.42758786153;118995.99999999914;9635.662751803653;12013;12092.87907120935;12156.452959616838;12263.448144833505;12140.057590785433;14200;14721.263936803118;14721.484748033767;14731.484398046017;8323.250907418362;8625.223729864218;9175;9274.721758347261;9275.907240927505;7883.6058197089915;8851.51316677576;9150.084991500797;9157.221636161;9183.63265469387;4817.445993710769;4830.903381932341;4856.417229932431;4871.80512779492;4902.607791376681;2023.382868225176;2071.150828160447;2083.260442542906;2117.8729276243475;2122.7771084036262;917.7567944494714;965.8744363232876;1002.7643503776607;1010.3129871687323;1116.268843907242;16756.664866702842;20636;21558;22086.77913220847;22406.43983900383;985.9507024648739;1004.5128112865254;1010.4594042187395;1017.6746135081452;1020.7958408318366;10782.730431739112;11076.446177691245;11089.500972456097;11097.611583594697;11113.333200008025;637183;664513;672207;685893;687456;99806.9758046419;136452;139287;139894;140919;929.2055292724758;1079.6275285026654;1091.7980173667738;1117.502711293483;1124.1231839165464;19105.90447047756;19204.71192932135;19250.7112393317;19282.807171928664;19535.316263930694;52205.7389713049;52837.471625284794;52910;54199.45800541944;55357;73532.63233683797;73766;76458.85311720218;80340;81937.59031204807;7099.432045436456;8351.540665263468;8544.487330760174;8700.738977830675;8931.972823125423;10827.621033263798;13072.477100915858;13118.475260989453;13358.9332053343;13369.26469044173;10982.560697572007;11114.22200445961;11177.888221117684;11289.887101128883;11551.653450396501;11070.114390848552;11077.335359878432;11322.94338528302;11395.943020284845;11435.028022617838;11023.61417350389;11478.598249061242;11747.823782643096;12043.397830108635;12078.456469459072;8347.666093356198;8407.915920840958;8472;8638.438501497383;8799.780005499913;10174.338667986558;11488;11727.706807329885;11803.763924721628;11845.23006004607 06:47:05 INFO - PROCESS | 1660 | |3;mootools.html;1476.1438365747867;1586.4447443394813;1623.0180740651901;1918.503567217571;2034.9796502034976;8333.62498687559;8955.328350373724;9112.362134650577;9115.817683646323;9129.817403651923;8877.156670116328;9113.68102116426;9153.405028673149;9156.954215228914;9168.770780730485;2556.5653838847347;2584.5735453650127;2588;2588.961165582518;2589.9741002590017;2208.933731988035;2522.155078048856;2541.59334506479;2581.045013345065;2584.237649893286;2490.2653717153394;2539.5809691400896;2559.897604095834;2560.590305551112;2563.8333508321994;2544.3511904464335;2578.8452692838396;2583.9612405813928;2584.5993870950033;2584.5993870950033;2537.9238622841344;2564.551203539373;2579.1102069785893;2582.4447743735;2583.2637698256094;8834.823303533893;9176.587053582538;9228;9232.353735238536;9245.121713437213;5589.7205139743255;5749.281339832521;5793.420657934215;5804.506616937565;5817.447342502498;3233.757468189895;3603.045193023851;3728.9067773305615;3794.2790869734663;3804.4673745675627;1050.3277902142636;1072.4905669806858;1073.6456969200144;1075.9677209683723;1087.4399684162663;12160.027197824153;12264;12428.067894907917;12448;12449.190802597892;4738.95261047392;4835.492273311322;4853.733044682576;4907.33750943618;4925.975370123198;9692.369995950241;9702.75743106414;9721.9027809721;9723.416595004323;9738.561764720605;5572.526335261548;5600.047991841397;5607.831765047055;5612.186232996274;5618.101103823368;4613;4710.458297295786;5037.974810125926;5117.820876269313;5196.688198708014;4015.3976903464713;4042.312806822847;4101.056756945919;4127.215828992542;4132.690048246393;1273.2042473454092;1279.394360078096;1279.8656141105237;1291.6383412644475;1291.6383412644475;941.2893265584577;972.7130496503548;974.1914211204684;976.4239098931522;1001.5593139018808;6061.727037322124;6123.877522449526;6192.845178870564;6294.8111556653375;6305.8108256752375;469.50701763148555;487.09157421408815;495.1977795970551;498.87777494514074;499.6577344519016;3968.305546529346;4060.2488539620263;4085.754854708727;4134.875953721393;4171.916561668811;10880.891191087987;11342.489587968561;11381.430928453545;11398.259113157617;11404.657860264206;10366.585336586451;11121.110311175087;11144.164187685956;11151.609693660683;11156.832647510293;8657.047724750273;8724.69463568772;8771.342149338698;8822.426542274732;8824.470531768115;5874.383189765013;6099.390060994043;6161.969190154021;6270.4670103039925;6289.96855015722;9498.477583732962;9888.752781180528;10217.74455638615;10229.693109206735;10245.590176392861;9152.17630413266;9662.75843103928;9922.355046921926;10095.091441770275;10114.342567733074;8167.469114507538;8375.036870759941;8511.446755961091;8523.275521580736;8563.61463734146;8561.57192140403;8582.399232053696;8626.698065567674;8633.17984791469;8670;6489.707963141765;7457.40340772726;7608.619569021416;7621.352185064332;7736.806579835549;7408.888666700038;7433.814154645961;7483.588402637907;7626.428017898569;7675.002249707502;7124.180719217356;7202.89195662076;7207.891881621885;7215.567065976058;7234.493585448968;4909.852704418873;4962.305277261258;5095.286659867547;5166.974165129151;5196.376434827845;5076.162433198629;5128.538431541179;5173.92239116406;5204.401493828107;5261.684298942076 06:47:05 INFO - PROCESS | 1660 | |4;prototype.html;334.9045522026222;339.80631040307037;345.2025820354979;351.1432105662184;355.5466779855682;6718.093057437244;6726.091977583031;6765.661716914153;6821.351971562706;6822.9765535169745;5584.827186290873;5867.88264234715;6713.597184168953;6721.462283017359;6748.6625668716615;4794.712317260967;4877.70733755974;4911.926321105187;4944.258361245824;4968.130577149002;4888;4961.677490963094;4964.851054468371;4989.476105008976;5012.674176178537;4272.739541835166;4928.728919909404;4977.601791856661;4988.87527811804;4995.150824359867;4019.678425725935;4572.451305843287;4785.014219099087;4892.046051020053;4906.558409743105;3600.459931010343;4213.705040647156;4237.724547904407;4239;4243.342281946272;5570.442955704397;6380.680965951684;6401.847667419863;6491.350864913518;6501.284858665543;5087.694738315713;5627.8593035174445;5904.114382842565;5932.970335148297;5944.7324870380935;5941.316748573926;7031.859362812766;7162.856742865113;7171.067761191064;7192.388646965014;4697.802060474592;4756.881077973044;4803.903921921542;4828.903421931577;4845.442774080991;6450.193945695166;7562.621868906588;7565.773026809205;7574.356179724675;7579.052618422697;4881.560659540658;4911.336969509142;4919.877003074952;4925.7783399747095;4926.014797040606;4989.351384320015;4992.975035124801;4996.950030499721;4999.150144475375;5006.274090256965;5037.647364684437;5919.704014799243;5936.495397891142;5943.197668314722;5955.880882382328;6171.783987560503;7199.820004499825;7208.675609597581;7214;7223.9638801806705;1621.3109428492844;1663.2432243329256;1663.3615888349966;1667.8999260044436;1668.1409074326732;1006.2050979726081;1047.3611097230682;1049.4437947887632;1067.1196263082988;1078.3799315393524;6606.636634985122;6612;6670.766523171763;6671.566348187353;6692.59844409337;6048.637081775108;7262.273772622695;7407.222241664547;7465.477416580788;7477;6060.757569697163;6306.148669929593;6816.352446517573;6831.897521537181;6832.111825462658;3900.76595404271;3945.723799334019;3948.170884114311;3958.050067983721;3959.425883246913;7513.4740568159705;7838.568878711611;7849.646765895548;7852.136265010844;7861.523620059663;7650.655720492591;7718.884216736754;7721.112072111667;7724.497907635986;7739.92260077392;6608.702608382634;7499.987501687202;7829.530228186327;7835.412344074103;7841.647125879349;7205.423566114803;7445.181030086795;7464.888026679713;7475.0656167979005;7482.438817088631;7327.926720732725;7346.155192152971;7364.705411783469;7377.483576149618;7383.630818459163;6216.471599914058;7741.032370953631;7841.490303130278;7842.882356764539;7848.7645370638975;4707.670463067552;4774.474807771212;4777.283407488904;4782.832600858953;4786.377770889762;7178.8564228714085;7407.703691852265;7432.665530051268;7452.329290363893;7472.215417381097;7136.643167841691;7200.855982880418;7210.567365958059;7215.422766178588;7219.819504512429;7157.141143062866;7161.21226665056;7174;7175.354218120394;7187.6765545551625;7035.47233957445;7038.718451262097;7040.436765058681;7046.647667616701;7059.929400705927;5562.915231529812;5823.534117270693;7102.218755936739;7185.461090418135;7205.135383753983;6710.496712746466;6843.178818541807;6868.656567171722;6976.162860456575;7011.509194356346 06:47:05 INFO - PROCESS | 1660 | |5;yui.html;700.3871612339203;733.6588486353846;746.1009483572296;781.4686013510814;785.195174945681;15270.847291527081;15456.995295305811;15474.767878481833;15480.458183963563;15515.456959006437;14188;14350.354234059467;14351.569452916428;14351.784723229133;14393.64015899603;787.3071696906715;805.0379796143611;952.5618215620823;986.7829077602952;991.5538007896439;961.1589858873485;968.8788901387327;973.3624475968252;974.6393834281325;980.9846808553149;838.375410319313;1035.0891215730185;1039.6465201831377;1040.6981975227175;1040.9427481488515;1024.4416792847878;1057.8148823955778;1059.9523021464054;1060.6711919305;1061.3950048472375;793.4049462902823;796.0765512006045;797.4935915693518;799.3844739550514;800.6877317846045;15252.38990440381;15347.386104555804;15355.539333820003;15362.539123826304;15364;13240.271785051818;13331.400086996011;13484.123531970488;13558.254296013716;13575.185488870698;9224.631014759469;9950.402975821402;9970.20238380935;10080.193584513221;10175.694729158136;3015.336625942289;3598.452665353897;3605.080704420382;3682.558093028827;3703.185299234164;81243.59378203072;81829;82307;83831;84200.57899710523;9508.381955172892;9522.666706665234;9669.516524173763;9849.310548261696;9901.356411833207;17474.825251747574;21552.461188470414;21886.781132188793;21904.9047547622;21936.45158871041;7527.9084532742445;7534.714995093865;7759.495632783851;7930.405219608552;8005.799855003672;4142.565030671736;4200.369944508348;4244.617984381421;4245.27830268855;4268;3791.7156213284115;3844.942325865114;3856.421536769451;3861.092643228839;3867.3425517662067;701.5930760159096;704.6371118873784;715.0561259137888;715.3204455767042;717.2612209424301;542.8073034072926;587.2600523340622;610.8442347201524;619.4486906653083;636.9426751592334;8013.078495972921;8233.259006689426;8244.670213191524;8280.171982801792;8309.529477108581;511.3454777884314;603.0833133636935;632.3265722006141;640.1102467570081;643.1446176585224;3507.5264839246884;3715.1640880802142;3876.8061596920043;3913.5108111486065;4069.2268468990796;83431.58284208662;88753;89655;90005.19989600171;90320;76007;77091;77110;77351.61324193455;79150.6042469784;67100;67356.6632166836;67992.66003670049;68386.31613683898;70331;7769.92230077692;7791.64937577799;7839.490433121829;7864.5281283123195;7918.604069796603;48472.757636211594;49976;50066.74966625144;50360.496395037044;51144.488555113974;59985.40014599973;64819.703605926676;68583.65708171428;68725;69464;9985.750356241153;10201.540930658286;10251.948740256252;10264.743381415525;10389.84415233757;10931.18016148776;11071.225014248925;11128.109751220045;11225.494852731483;11771.999380052792;9718.271129665161;9781.853272201066;9914.23143127871;10154.949225253826;10209.591616335263;10341.017603327671;10419.462166597856;10420.478976051016;10431.739206519898;10493.895061049292;10066.748331291776;10138.23963202748;10145.898541014496;10149.188064954933;10704.571817127227;8735.519546424754;8895.154960278764;8919.509058097441;9031;9062.728118156467;8887.955560222157;8921.687740929035;9005.549722513717;9112.498812565107;9113.088691130833 06:47:05 INFO - PROCESS | 1660 | __end_tp_report 06:47:05 INFO - PROCESS | 1660 | __start_cc_report 06:47:05 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1098 06:47:05 INFO - PROCESS | 1660 | __end_cc_report 06:47:05 INFO - PROCESS | 1660 | __startTimestamp1468504025164__endTimestamp 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:47:05 INFO - PROCESS | 1660 | Number of tests: 6 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5972.46 Median:6215.10 stddev:637.05 (10.3%) stddev-sans-first:611.48 06:47:05 INFO - PROCESS | 1660 | Values: 3610.9 3632.2 3654.2 3656.5 3704.9 6076.5 6094.3 6102.4 6108.3 6122.5 6085.0 6100.1 6127.9 6133.1 6135.1 5400.6 5459.9 5499.9 5513.5 5580.1 5497.4 5561.7 5563.0 5565.7 5575.3 5450.3 5514.3 5531.9 5542.8 5575.4 5498.2 5535.6 5560.8 5563.5 5574.2 5373.8 5376.3 5463.2 5464.5 5468.1 5968.7 6052.8 6056.3 6059.5 6083.5 6379.2 6388.4 6393.4 6400.2 6413.2 6350.6 6402.2 6497.2 6507.7 6516.3 6160.1 6173.5 6197.9 6207.4 6210.0 6581.3 6594.9 6598.6 6604.3 6607.9 5353.9 6215.1 6291.8 6357.8 6367.4 6478.2 6483.7 6486.5 6490.3 6510.6 6313.4 6363.8 6377.1 6389.0 6391.5 6223.8 6329.4 6330.2 6348.0 6385.1 5087.4 5092.8 5141.1 5153.0 5164.1 4603.2 4606.0 4607.2 4613.8 4643.7 6113.9 6137.9 6150.4 6152.6 6160.4 6323.5 6384.4 6395.9 6478.5 6485.6 5941.6 6003.1 6072.8 6129.4 6154.6 5612.0 5624.0 5635.0 5669.5 5732.7 6377.8 6480.9 6508.6 6518.0 6527.3 6385.5 6399.9 6403.5 6405.4 6600.6 6635.5 6635.5 6639.9 6642.3 6652.2 6216.3 6292.6 6355.0 6369.4 6383.8 6315.2 6393.4 6407.8 6409.3 6412.4 4916.9 6287.9 6304.0 6308.4 6312.2 6229.2 6271.7 6279.3 6283.7 6346.7 4877.2 5129.3 5370.2 6266.9 6321.4 6255.8 6274.0 6314.1 6323.8 6325.9 6114.8 6200.7 6237.0 6243.4 6277.5 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:64604.63 Median:36573.04 stddev:139197.59 (380.6%) stddev-sans-first:139504.91 06:47:05 INFO - PROCESS | 1660 | Values: 517.3 518.7 574.0 584.5 612.2 30149.7 32722.8 37550.2 38661.0 38669.6 43226.0 43445.8 43457.8 43596.6 43626.6 9634.8 9858.9 9859.8 9860.0 9863.3 9232.9 11757.4 12008.5 12026.6 12031.5 11743.8 11851.7 11860.1 11882.3 11908.0 11742.4 11900.2 11904.4 11913.6 11922.5 11467.4 11683.2 11695.4 11709.2 11712.6 41557.6 41998.0 42061.8 42077.6 42450.6 3252.1 3422.9 3661.5 3669.8 4001.9 28875.4 29563.6 29748.4 29749.0 30010.4 2820.2 2836.5 2869.2 2885.2 2888.5 452962.0 542715.3 542951.3 545013.0 551911.0 37102.8 61227.1 61255.7 61740.0 61858.7 36406.0 36558.0 36571.3 36574.8 36614.8 16375.4 16512.3 16516.6 16553.3 16562.1 12970.7 13811.3 13926.9 14041.0 14188.4 8431.2 8439.2 8483.2 8509.9 8519.1 3494.5 3519.5 3525.0 3535.1 3554.9 986.3 991.2 1031.2 1064.8 1096.3 28671.4 30922.7 31080.8 31129.7 31775.7 1180.1 1181.7 1211.7 1234.3 1322.5 15674.8 15911.0 15960.8 15966.7 16309.9 538032.0 640368.0 650357.0 656530.0 657680.0 63830.7 64364.7 64472.7 64482.0 64512.0 1390.0 1412.3 1536.7 1537.9 1612.7 28323.2 29192.0 29684.9 30211.7 30243.8 48591.8 48821.8 48920.8 48965.8 49061.5 367766.0 371243.0 371300.0 371435.0 372379.0 28255.6 28345.0 43677.9 45684.5 45814.5 43141.8 45065.8 45133.6 45183.0 45753.3 37060.8 37922.8 38178.6 38415.8 39293.6 37193.8 38108.0 38204.0 38545.6 38906.8 37539.6 37655.0 38618.2 38706.4 38787.0 33143.3 33759.7 34143.3 34207.5 34269.8 22513.0 23345.3 25575.5 25681.2 25765.0 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:36423.71 Median:2120.33 stddev:111003.14 (5235.2%) stddev-sans-first:111281.61 06:47:05 INFO - PROCESS | 1660 | Values: 421.4 421.6 424.4 425.2 436.5 20200.5 20481.6 21058.0 21137.6 21150.7 17693.8 20559.8 21040.6 21613.5 21624.9 5447.8 5969.5 5978.2 5984.4 5993.8 5829.9 5966.3 5974.4 5976.8 5977.7 5637.6 5930.6 5930.9 5935.1 5935.7 5816.1 5890.3 5892.9 5899.5 5901.1 5509.9 5832.4 5845.6 5853.6 5857.4 14020.4 14091.9 14354.6 14387.5 14539.0 2053.7 2141.0 2185.5 2325.8 2587.2 9772.6 10008.8 10104.0 10339.6 10476.7 1836.1 1853.2 1856.7 1887.6 1942.6 66377.0 97638.0 104877.0 114482.4 118996.0 9635.7 12013.0 12092.9 12156.5 12263.4 12140.1 14200.0 14721.3 14721.5 14731.5 8323.3 8625.2 9175.0 9274.7 9275.9 7883.6 8851.5 9150.1 9157.2 9183.6 4817.4 4830.9 4856.4 4871.8 4902.6 2023.4 2071.2 2083.3 2117.9 2122.8 917.8 965.9 1002.8 1010.3 1116.3 16756.7 20636.0 21558.0 22086.8 22406.4 986.0 1004.5 1010.5 1017.7 1020.8 10782.7 11076.4 11089.5 11097.6 11113.3 637183.0 664513.0 672207.0 685893.0 687456.0 99807.0 136452.0 139287.0 139894.0 140919.0 929.2 1079.6 1091.8 1117.5 1124.1 19105.9 19204.7 19250.7 19282.8 19535.3 52205.7 52837.5 52910.0 54199.5 55357.0 73532.6 73766.0 76458.9 80340.0 81937.6 7099.4 8351.5 8544.5 8700.7 8932.0 10827.6 13072.5 13118.5 13358.9 13369.3 10982.6 11114.2 11177.9 11289.9 11551.7 11070.1 11077.3 11322.9 11395.9 11435.0 11023.6 11478.6 11747.8 12043.4 12078.5 8347.7 8407.9 8472.0 8638.4 8799.8 10174.3 11488.0 11727.7 11803.8 11845.2 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5917.51 Median:5057.07 stddev:3297.61 (65.2%) stddev-sans-first:3289.97 06:47:05 INFO - PROCESS | 1660 | Values: 1476.1 1586.4 1623.0 1918.5 2035.0 8333.6 8955.3 9112.4 9115.8 9129.8 8877.2 9113.7 9153.4 9157.0 9168.8 2556.6 2584.6 2588.0 2589.0 2590.0 2208.9 2522.2 2541.6 2581.0 2584.2 2490.3 2539.6 2559.9 2560.6 2563.8 2544.4 2578.8 2584.0 2584.6 2584.6 2537.9 2564.6 2579.1 2582.4 2583.3 8834.8 9176.6 9228.0 9232.4 9245.1 5589.7 5749.3 5793.4 5804.5 5817.4 3233.8 3603.0 3728.9 3794.3 3804.5 1050.3 1072.5 1073.6 1076.0 1087.4 12160.0 12264.0 12428.1 12448.0 12449.2 4739.0 4835.5 4853.7 4907.3 4926.0 9692.4 9702.8 9721.9 9723.4 9738.6 5572.5 5600.0 5607.8 5612.2 5618.1 4613.0 4710.5 5038.0 5117.8 5196.7 4015.4 4042.3 4101.1 4127.2 4132.7 1273.2 1279.4 1279.9 1291.6 1291.6 941.3 972.7 974.2 976.4 1001.6 6061.7 6123.9 6192.8 6294.8 6305.8 469.5 487.1 495.2 498.9 499.7 3968.3 4060.2 4085.8 4134.9 4171.9 10880.9 11342.5 11381.4 11398.3 11404.7 10366.6 11121.1 11144.2 11151.6 11156.8 8657.0 8724.7 8771.3 8822.4 8824.5 5874.4 6099.4 6162.0 6270.5 6290.0 9498.5 9888.8 10217.7 10229.7 10245.6 9152.2 9662.8 9922.4 10095.1 10114.3 8167.5 8375.0 8511.4 8523.3 8563.6 8561.6 8582.4 8626.7 8633.2 8670.0 6489.7 7457.4 7608.6 7621.4 7736.8 7408.9 7433.8 7483.6 7626.4 7675.0 7124.2 7202.9 7207.9 7215.6 7234.5 4909.9 4962.3 5095.3 5167.0 5196.4 5076.2 5128.5 5173.9 5204.4 5261.7 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5829.71 Median:6553.96 stddev:1860.78 (28.4%) stddev-sans-first:1819.72 06:47:05 INFO - PROCESS | 1660 | Values: 334.9 339.8 345.2 351.1 355.5 6718.1 6726.1 6765.7 6821.4 6823.0 5584.8 5867.9 6713.6 6721.5 6748.7 4794.7 4877.7 4911.9 4944.3 4968.1 4888.0 4961.7 4964.9 4989.5 5012.7 4272.7 4928.7 4977.6 4988.9 4995.2 4019.7 4572.5 4785.0 4892.0 4906.6 3600.5 4213.7 4237.7 4239.0 4243.3 5570.4 6380.7 6401.8 6491.4 6501.3 5087.7 5627.9 5904.1 5933.0 5944.7 5941.3 7031.9 7162.9 7171.1 7192.4 4697.8 4756.9 4803.9 4828.9 4845.4 6450.2 7562.6 7565.8 7574.4 7579.1 4881.6 4911.3 4919.9 4925.8 4926.0 4989.4 4993.0 4997.0 4999.2 5006.3 5037.6 5919.7 5936.5 5943.2 5955.9 6171.8 7199.8 7208.7 7214.0 7224.0 1621.3 1663.2 1663.4 1667.9 1668.1 1006.2 1047.4 1049.4 1067.1 1078.4 6606.6 6612.0 6670.8 6671.6 6692.6 6048.6 7262.3 7407.2 7465.5 7477.0 6060.8 6306.1 6816.4 6831.9 6832.1 3900.8 3945.7 3948.2 3958.1 3959.4 7513.5 7838.6 7849.6 7852.1 7861.5 7650.7 7718.9 7721.1 7724.5 7739.9 6608.7 7500.0 7829.5 7835.4 7841.6 7205.4 7445.2 7464.9 7475.1 7482.4 7327.9 7346.2 7364.7 7377.5 7383.6 6216.5 7741.0 7841.5 7842.9 7848.8 4707.7 4774.5 4777.3 4782.8 4786.4 7178.9 7407.7 7432.7 7452.3 7472.2 7136.6 7200.9 7210.6 7215.4 7219.8 7157.1 7161.2 7174.0 7175.4 7187.7 7035.5 7038.7 7040.4 7046.6 7059.9 5562.9 5823.5 7102.2 7185.5 7205.1 6710.5 6843.2 6868.7 6976.2 7011.5 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18018.61 Median:638.53 stddev:25335.84 (3967.9%) stddev-sans-first:25373.54 06:47:05 INFO - PROCESS | 1660 | Values: 700.4 733.7 746.1 781.5 785.2 15270.8 15457.0 15474.8 15480.5 15515.5 14188.0 14350.4 14351.6 14351.8 14393.6 787.3 805.0 952.6 986.8 991.6 961.2 968.9 973.4 974.6 981.0 838.4 1035.1 1039.6 1040.7 1040.9 1024.4 1057.8 1060.0 1060.7 1061.4 793.4 796.1 797.5 799.4 800.7 15252.4 15347.4 15355.5 15362.5 15364.0 13240.3 13331.4 13484.1 13558.3 13575.2 9224.6 9950.4 9970.2 10080.2 10175.7 3015.3 3598.5 3605.1 3682.6 3703.2 81243.6 81829.0 82307.0 83831.0 84200.6 9508.4 9522.7 9669.5 9849.3 9901.4 17474.8 21552.5 21886.8 21904.9 21936.5 7527.9 7534.7 7759.5 7930.4 8005.8 4142.6 4200.4 4244.6 4245.3 4268.0 3791.7 3844.9 3856.4 3861.1 3867.3 701.6 704.6 715.1 715.3 717.3 542.8 587.3 610.8 619.4 636.9 8013.1 8233.3 8244.7 8280.2 8309.5 511.3 603.1 632.3 640.1 643.1 3507.5 3715.2 3876.8 3913.5 4069.2 83431.6 88753.0 89655.0 90005.2 90320.0 76007.0 77091.0 77110.0 77351.6 79150.6 67100.0 67356.7 67992.7 68386.3 70331.0 7769.9 7791.6 7839.5 7864.5 7918.6 48472.8 49976.0 50066.7 50360.5 51144.5 59985.4 64819.7 68583.7 68725.0 69464.0 9985.8 10201.5 10251.9 10264.7 10389.8 10931.2 11071.2 11128.1 11225.5 11772.0 9718.3 9781.9 9914.2 10154.9 10209.6 10341.0 10419.5 10420.5 10431.7 10493.9 10066.7 10138.2 10145.9 10149.2 10704.6 8735.5 8895.2 8919.5 9031.0 9062.7 8888.0 8921.7 9005.5 9112.5 9113.1 06:47:05 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:47:05 INFO - PROCESS | 1660 | 06:47:05 INFO - TEST-INFO | 1660: exit 0 06:47:05 INFO - TEST-OK | dromaeo_css | took 1113537ms 06:47:05 INFO - TEST-START | kraken 06:47:05 INFO - operating with platform_type : mac_ 06:47:05 INFO - Initialising browser for kraken test... 06:47:05 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp_7R6TP/profile http://localhost:49275/getInfo.html) 06:47:07 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 06:47:07 INFO - PROCESS | 1671 | colorDepth:24 06:47:07 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 06:47:07 INFO - PROCESS | 1671 | __metrics 06:47:08 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:47:08 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:47:08 INFO - TEST-INFO | 1671: exit 0 06:47:08 INFO - Browser initialized. 06:47:08 INFO - Running cycle 1/1 for kraken test... 06:47:08 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp_7R6TP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:20 INFO - PROCESS | 1674 | RSS: Main: 160313344 06:47:20 INFO - PROCESS | 1674 | 06:47:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:23 INFO - PROCESS | 1674 | RSS: Main: 224038912 06:47:23 INFO - PROCESS | 1674 | 06:47:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 06:47:27 INFO - PROCESS | 1674 | RSS: Main: 239960064 06:47:27 INFO - PROCESS | 1674 | 06:47:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 06:47:30 INFO - PROCESS | 1674 | RSS: Main: 325840896 06:47:30 INFO - PROCESS | 1674 | 06:47:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 06:47:33 INFO - PROCESS | 1674 | RSS: Main: 230375424 06:47:33 INFO - PROCESS | 1674 | 06:47:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:36 INFO - PROCESS | 1674 | RSS: Main: 231997440 06:47:36 INFO - PROCESS | 1674 | 06:47:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:39 INFO - PROCESS | 1674 | RSS: Main: 270774272 06:47:39 INFO - PROCESS | 1674 | 06:47:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:43 INFO - PROCESS | 1674 | RSS: Main: 270635008 06:47:43 INFO - PROCESS | 1674 | 06:47:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 06:47:46 INFO - PROCESS | 1674 | RSS: Main: 270262272 06:47:46 INFO - PROCESS | 1674 | 06:47:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:48 INFO - PROCESS | 1674 | RSS: Main: 259657728 06:47:48 INFO - PROCESS | 1674 | 06:47:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:51 INFO - PROCESS | 1674 | RSS: Main: 265723904 06:47:51 INFO - PROCESS | 1674 | 06:47:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:54 INFO - PROCESS | 1674 | RSS: Main: 271220736 06:47:54 INFO - PROCESS | 1674 | 06:47:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:57 INFO - PROCESS | 1674 | RSS: Main: 278302720 06:47:57 INFO - PROCESS | 1674 | 06:48:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:00 INFO - PROCESS | 1674 | RSS: Main: 275525632 06:48:00 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 06:48:02 INFO - PROCESS | 1674 | RSS: Main: 336748544 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | __start_tp_report 06:48:02 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 06:48:02 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 06:48:02 INFO - PROCESS | 1674 | |i|pagename|runs| 06:48:02 INFO - PROCESS | 1674 | |0;ai-astar;111;110;120;112;111;110;112;113;112;133 06:48:02 INFO - PROCESS | 1674 | |1;audio-beat-detection;176;146;172;162;116;145;142;178;174;116 06:48:02 INFO - PROCESS | 1674 | |2;audio-dft;185;186;186;185;184;183;185;185;186;183 06:48:02 INFO - PROCESS | 1674 | |3;audio-fft;69;78;74;154;56;55;57;65;129;55 06:48:02 INFO - PROCESS | 1674 | |4;audio-oscillator;114;114;177;100;79;80;122;79;76;130 06:48:02 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;86;90;86;89;84;89;85;88;84 06:48:02 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;93;93;96;102;134;147;93;93;92 06:48:02 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;85;84;84;83;84;83;85;80;82 06:48:02 INFO - PROCESS | 1674 | |8;json-parse-financial;58;62;61;62;63;62;64;79;59;56 06:48:02 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;61;62;61;77;71;69;66;69;65;65 06:48:02 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;80;79;101;101;102;69;81;99;106;108 06:48:02 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;124;128;134;143;125;124;124;125;143;140 06:48:02 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;165;161;162;164;161;163;164;165;161;163 06:48:02 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;66;67;68;68;67;66;66;70;85;94 06:48:02 INFO - PROCESS | 1674 | __end_tp_report 06:48:02 INFO - PROCESS | 1674 | __start_cc_report 06:48:02 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1907 06:48:02 INFO - PROCESS | 1674 | __end_cc_report 06:48:02 INFO - PROCESS | 1674 | __startTimestamp1468504082789__endTimestamp 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | ------- Summary: start ------- 06:48:02 INFO - PROCESS | 1674 | Number of tests: 14 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:114.40 Median:112.00 stddev:7.14 (6.4%) stddev-sans-first:7.46 06:48:02 INFO - PROCESS | 1674 | Values: 111.0 110.0 120.0 112.0 111.0 110.0 112.0 113.0 112.0 133.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:167.00 stddev:23.59 (14.1%) stddev-sans-first:23.47 06:48:02 INFO - PROCESS | 1674 | Values: 176.0 146.0 172.0 162.0 116.0 145.0 142.0 178.0 174.0 116.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.14 (0.6%) stddev-sans-first:1.20 06:48:02 INFO - PROCESS | 1674 | Values: 185.0 186.0 186.0 185.0 184.0 183.0 185.0 185.0 186.0 183.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:79.20 Median:61.00 stddev:34.34 (56.3%) stddev-sans-first:36.22 06:48:02 INFO - PROCESS | 1674 | Values: 69.0 78.0 74.0 154.0 56.0 55.0 57.0 65.0 129.0 55.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:126.50 stddev:31.73 (25.1%) stddev-sans-first:33.55 06:48:02 INFO - PROCESS | 1674 | Values: 114.0 114.0 177.0 100.0 79.0 80.0 122.0 79.0 76.0 130.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:2.18 (2.5%) stddev-sans-first:2.28 06:48:02 INFO - PROCESS | 1674 | Values: 88.0 86.0 90.0 86.0 89.0 84.0 89.0 85.0 88.0 84.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:93.00 stddev:19.90 (21.4%) stddev-sans-first:20.74 06:48:02 INFO - PROCESS | 1674 | Values: 93.0 93.0 93.0 96.0 102.0 134.0 147.0 93.0 93.0 92.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:83.50 Median:84.00 stddev:1.58 (1.9%) stddev-sans-first:1.58 06:48:02 INFO - PROCESS | 1674 | Values: 85.0 85.0 84.0 84.0 83.0 84.0 83.0 85.0 80.0 82.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:62.00 stddev:6.26 (10.1%) stddev-sans-first:6.41 06:48:02 INFO - PROCESS | 1674 | Values: 58.0 62.0 61.0 62.0 63.0 62.0 64.0 79.0 59.0 56.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.50 stddev:5.04 (7.5%) stddev-sans-first:4.92 06:48:02 INFO - PROCESS | 1674 | Values: 61.0 62.0 61.0 77.0 71.0 69.0 66.0 69.0 65.0 65.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:74.00 stddev:13.83 (18.7%) stddev-sans-first:13.90 06:48:02 INFO - PROCESS | 1674 | Values: 80.0 79.0 101.0 101.0 102.0 69.0 81.0 99.0 106.0 108.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:131.00 stddev:8.21 (6.3%) stddev-sans-first:8.30 06:48:02 INFO - PROCESS | 1674 | Values: 124.0 128.0 134.0 143.0 125.0 124.0 124.0 125.0 143.0 140.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.50 stddev:1.60 (1.0%) stddev-sans-first:1.50 06:48:02 INFO - PROCESS | 1674 | Values: 165.0 161.0 162.0 164.0 161.0 163.0 164.0 165.0 161.0 163.0 06:48:02 INFO - PROCESS | 1674 | 06:48:02 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:68.00 stddev:9.70 (14.3%) stddev-sans-first:10.06 06:48:02 INFO - PROCESS | 1674 | Values: 66.0 67.0 68.0 68.0 67.0 66.0 66.0 70.0 85.0 94.0 06:48:02 INFO - PROCESS | 1674 | -------- Summary: end -------- 06:48:02 INFO - PROCESS | 1674 | 06:48:03 INFO - TEST-INFO | 1674: exit 0 06:48:03 INFO - TEST-OK | kraken | took 57779ms 06:48:03 INFO - SUITE-END | took 1171s 06:48:03 INFO - Completed test suite (00:19:31) 06:48:03 INFO - javascript benchmark 06:48:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3610.909727256819, 3632.219072899326, 3654.214343916061, 3656.469811877277, 3704.851805927763, 6076.483498902588, 6094.26868775747, 6102.420270074342, 6108.328083910772, 6122.510199184066, 6085.0, 6100.084987251915, 6127.908081378783, 6133.1413602095745, 6135.110408990694, 5400.648957817729, 5459.890802183944, 5499.890002199953, 5513.50378465938, 5580.107182850745, 5497.422770609089, 5561.694106824123, 5563.0, 5565.749541270632, 5575.275214222145, 5450.345958484968, 5514.255575497296, 5531.861703457425, 5542.806001789938, 5575.386707462176, 5498.1752737089355, 5535.58483113768, 5560.77756889724, 5563.499285064364, 5574.219609254667, 5373.838784836422, 5376.327959005124, 5463.2078348639225, 5464.535514481274, 5468.050832289264, 5968.67172305523, 6052.848678783022, 6056.303525094627, 6059.460319987303, 6083.475357726583, 6379.170707808002, 6388.425041746265, 6393.360663933616, 6400.199975003125, 6413.230412350548, 6350.555461117724, 6402.167718196652, 6497.220333560003, 6507.674616269168, 6516.348365163493, 6160.0759886017, 6173.475254603364, 6197.938020619827, 6207.379262073847, 6210.037444196202, 6581.308962558958, 6594.868102638016, 6598.637074960827, 6604.306547812506, 6607.900881486781, 5353.9196912046355, 6215.098810672427, 6291.811245662638, 6357.777477788348, 6367.395097465734, 6478.190226221723, 6483.740650374027, 6486.545941784124, 6490.318516555788, 6510.609363438209, 6313.43179113882, 6363.777267795697, 6377.075324078076, 6389.0, 6391.456726178234, 6223.813285601439, 6329.430351268408, 6330.208723909512, 6347.96826015867, 6385.10608514799, 5087.364079490064, 5092.821751238689, 5141.126008578551, 5153.0, 5164.122099243138, 4603.240465323252, 4605.976970115195, 4607.193741095295, 4613.8385156520035, 4643.721376717408, 6113.908291375633, 6137.925862973962, 6150.354212807681, 6152.630842149485, 6160.414760597736, 6323.494120470351, 6384.3934826191435, 6395.904061439082, 6478.481721462272, 6485.6108633482145, 5941.554383421174, 6003.129546215774, 6072.787452439144, 6129.387061293835, 6154.599951003171, 5611.971940140274, 5624.0439125348785, 5635.0, 5669.518090962232, 5732.656040637575, 6377.840553986095, 6480.902786458301, 6508.60948343101, 6517.967410162919, 6527.314631963671, 6385.521085918667, 6399.93600064012, 6403.4877209824035, 6405.423511883952, 6600.60396376219, 6635.502337324817, 6635.535512514078, 6639.900401494078, 6642.302558231316, 6652.201735791542, 6216.316205217513, 6292.590981586182, 6355.014972679242, 6369.426751592379, 6383.808485745435, 6315.179026726496, 6393.392627700361, 6407.775727849503, 6409.327020662763, 6412.422881940648, 4916.926246106383, 6287.937120628735, 6304.022876454157, 6308.400701933309, 6312.242530896322, 6229.1590635265475, 6271.74913003493, 6279.30927597973, 6283.748650053946, 6346.650934198478, 4877.244027175793, 5129.281900533853, 5370.221317908803, 6266.874662506815, 6321.399467050623, 6255.843603909939, 6274.027525733519, 6314.084457753692, 6323.810285691437, 6325.905111423241, 6114.814446323713, 6200.689965501797, 6237.0, 6243.375662433902, 6277.529185311028], "value": 5935.132390714593, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.2732311102901, 518.7354449230891, 574.0126981591666, 584.4593750780529, 612.2041346249877, 30149.698503014963, 32722.836385818067, 37550.24899502012, 38661.03347416309, 38669.61330386695, 43226.0, 43445.78277108618, 43457.78271108648, 43596.564034359646, 43626.563734362644, 9634.759131021729, 9858.901410985905, 9859.753506162331, 9860.013998600118, 9863.30956833022, 9232.8615070774, 11757.353345566033, 12008.519659213622, 12026.639200823989, 12031.51873925042, 11743.823842642325, 11851.703707407298, 11860.110491713112, 11882.28706277626, 11908.0, 11742.354170520617, 11900.166988310822, 11904.404779760976, 11913.583024594183, 11922.463489143009, 11467.426628668532, 11683.182177247596, 11695.41522923859, 11709.238899471507, 11712.590059347967, 41557.58442415568, 41998.0, 42061.78969105166, 42077.57922420767, 42450.57549424497, 3252.1381833814057, 3422.8801991930163, 3661.5423072115987, 3669.8165091745304, 4001.9399709004388, 28875.42249155026, 29563.556546651816, 29748.40503189924, 29749.0, 30010.420284821073, 2820.2244382794897, 2836.517791975369, 2869.239651492356, 2885.2354126156583, 2888.508953477914, 452962.0, 542715.2864235693, 542951.2852435752, 545013.0, 551911.0, 37102.814485927396, 61227.08159377613, 61255.693721532, 61740.0, 61858.69070654708, 36406.0, 36558.0, 36571.26857462889, 36574.817125914204, 36614.8169259152, 16375.42686005984, 16512.33950641961, 16516.587085322964, 16553.25510352037, 16562.089085100193, 12970.675733106558, 13811.309434528433, 13926.860731392557, 14041.01712880109, 14188.361523731457, 8431.15688431152, 8439.240468357877, 8483.194096560817, 8509.872351914726, 8519.148085191555, 3494.545709057806, 3519.472079188091, 3524.9823750881083, 3535.116220944764, 3554.928901422009, 986.3440811860032, 991.2020823237364, 1031.1905154453718, 1064.84559738839, 1096.276457538021, 28671.42657146887, 30922.690773092432, 31080.844595776878, 31129.668979795973, 31775.682243177736, 1180.138498895811, 1181.6750393641817, 1211.733418647896, 1234.2717796500108, 1322.490841026212, 15674.764878526832, 15911.0, 15960.840391596168, 15966.680666386606, 16309.918450407671, 538032.0, 640368.0, 650357.0, 656530.0, 657680.0, 63830.72338553296, 64364.67817660882, 64472.677636611515, 64482.0, 64512.032319515245, 1389.9930500347637, 1412.2797373339465, 1536.6926614677109, 1537.93079311429, 1612.7338989066907, 28323.150305490868, 29192.0, 29684.851575741985, 30211.69788302089, 30243.848780755954, 48591.757041214565, 48821.75589122032, 48920.75539622279, 48965.77585560247, 49061.509384905694, 367766.0, 371243.0, 371300.0, 371435.0, 372379.0, 28255.576166357932, 28345.007924722537, 43677.908052298946, 45684.543154568026, 45814.54185458236, 43141.784291078344, 45065.77467112643, 45133.64599062033, 45183.0, 45753.33973282196, 37060.84982776494, 37922.810385947894, 38178.618213817506, 38415.84752457431, 39293.60706393014, 37193.81403092967, 38108.0, 38204.04489887775, 38545.6145438542, 38906.8327950162, 37539.62460375361, 37655.0, 38618.22763544769, 38706.4194037084, 38787.0, 33143.33713325672, 33759.72256626208, 34143.317133657685, 34207.48688769621, 34269.828650857584, 22512.986915589165, 23345.299641010795, 25575.488490230462, 25681.22956311314, 25764.96940122374], "value": 19435.5637788873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.4121300785404, 421.6015865007568, 424.39523678757763, 425.2069889655791, 436.5263688897546, 20200.494987625334, 20481.59036819263, 21058.0, 21137.57724845502, 21150.682739758915, 17693.823061769377, 20559.794402055973, 21040.57918841626, 21613.45966350842, 21624.918754062273, 5447.754851031703, 5969.462748352647, 5978.163057172, 5984.431479009487, 5993.760249590011, 5829.883402331972, 5966.343702192756, 5974.4324289192455, 5976.820695379146, 5977.731002104916, 5637.577181711367, 5930.614510056854, 5930.851728706773, 5935.050391937291, 5935.703214839263, 5816.069428891378, 5890.322612899486, 5892.941070589325, 5899.528037756991, 5901.085331773604, 5509.944900550983, 5832.387599302097, 5845.561582881301, 5853.5902486825935, 5857.384974577651, 14020.369083391271, 14091.859081409157, 14354.64113397163, 14387.496437624633, 14539.0, 2053.7330147080784, 2140.9892950535304, 2185.519185779126, 2325.837191396603, 2587.236765154284, 9772.560234789451, 10008.799824003552, 10104.040116189024, 10339.586416543329, 10476.738081548023, 1836.0904659154464, 1853.184598776534, 1856.693645548483, 1887.631911777204, 1942.5629233422508, 66377.0, 97638.0, 104876.95123048748, 114482.42758786153, 118995.99999999914, 9635.662751803653, 12013.0, 12092.87907120935, 12156.452959616838, 12263.448144833505, 12140.057590785433, 14200.0, 14721.263936803118, 14721.484748033767, 14731.484398046017, 8323.250907418362, 8625.223729864218, 9175.0, 9274.721758347261, 9275.907240927505, 7883.6058197089915, 8851.51316677576, 9150.084991500797, 9157.221636161, 9183.63265469387, 4817.445993710769, 4830.903381932341, 4856.417229932431, 4871.80512779492, 4902.607791376681, 2023.382868225176, 2071.150828160447, 2083.260442542906, 2117.8729276243475, 2122.7771084036262, 917.7567944494714, 965.8744363232876, 1002.7643503776607, 1010.3129871687323, 1116.268843907242, 16756.664866702842, 20636.0, 21558.0, 22086.77913220847, 22406.43983900383, 985.9507024648739, 1004.5128112865254, 1010.4594042187395, 1017.6746135081452, 1020.7958408318366, 10782.730431739112, 11076.446177691245, 11089.500972456097, 11097.611583594697, 11113.333200008025, 637183.0, 664513.0, 672207.0, 685893.0, 687456.0, 99806.9758046419, 136452.0, 139287.0, 139894.0, 140919.0, 929.2055292724758, 1079.6275285026654, 1091.7980173667738, 1117.502711293483, 1124.1231839165464, 19105.90447047756, 19204.71192932135, 19250.7112393317, 19282.807171928664, 19535.316263930694, 52205.7389713049, 52837.471625284794, 52910.0, 54199.45800541944, 55357.0, 73532.63233683797, 73766.0, 76458.85311720218, 80340.0, 81937.59031204807, 7099.432045436456, 8351.540665263468, 8544.487330760174, 8700.738977830675, 8931.972823125423, 10827.621033263798, 13072.477100915858, 13118.475260989453, 13358.9332053343, 13369.26469044173, 10982.560697572007, 11114.22200445961, 11177.888221117684, 11289.887101128883, 11551.653450396501, 11070.114390848552, 11077.335359878432, 11322.94338528302, 11395.943020284845, 11435.028022617838, 11023.61417350389, 11478.598249061242, 11747.823782643096, 12043.397830108635, 12078.456469459072, 8347.666093356198, 8407.915920840958, 8472.0, 8638.438501497383, 8799.780005499913, 10174.338667986558, 11488.0, 11727.706807329885, 11803.763924721628, 11845.23006004607], "value": 9643.46461913439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.1438365747867, 1586.4447443394813, 1623.0180740651901, 1918.503567217571, 2034.9796502034976, 8333.62498687559, 8955.328350373724, 9112.362134650577, 9115.817683646323, 9129.817403651923, 8877.156670116328, 9113.68102116426, 9153.405028673149, 9156.954215228914, 9168.770780730485, 2556.5653838847347, 2584.5735453650127, 2588.0, 2588.961165582518, 2589.9741002590017, 2208.933731988035, 2522.155078048856, 2541.59334506479, 2581.045013345065, 2584.237649893286, 2490.2653717153394, 2539.5809691400896, 2559.897604095834, 2560.590305551112, 2563.8333508321994, 2544.3511904464335, 2578.8452692838396, 2583.9612405813928, 2584.5993870950033, 2584.5993870950033, 2537.9238622841344, 2564.551203539373, 2579.1102069785893, 2582.4447743735, 2583.2637698256094, 8834.823303533893, 9176.587053582538, 9228.0, 9232.353735238536, 9245.121713437213, 5589.7205139743255, 5749.281339832521, 5793.420657934215, 5804.506616937565, 5817.447342502498, 3233.757468189895, 3603.045193023851, 3728.9067773305615, 3794.2790869734663, 3804.4673745675627, 1050.3277902142636, 1072.4905669806858, 1073.6456969200144, 1075.9677209683723, 1087.4399684162663, 12160.027197824153, 12264.0, 12428.067894907917, 12448.0, 12449.190802597892, 4738.95261047392, 4835.492273311322, 4853.733044682576, 4907.33750943618, 4925.975370123198, 9692.369995950241, 9702.75743106414, 9721.9027809721, 9723.416595004323, 9738.561764720605, 5572.526335261548, 5600.047991841397, 5607.831765047055, 5612.186232996274, 5618.101103823368, 4613.0, 4710.458297295786, 5037.974810125926, 5117.820876269313, 5196.688198708014, 4015.3976903464713, 4042.312806822847, 4101.056756945919, 4127.215828992542, 4132.690048246393, 1273.2042473454092, 1279.394360078096, 1279.8656141105237, 1291.6383412644475, 1291.6383412644475, 941.2893265584577, 972.7130496503548, 974.1914211204684, 976.4239098931522, 1001.5593139018808, 6061.727037322124, 6123.877522449526, 6192.845178870564, 6294.8111556653375, 6305.8108256752375, 469.50701763148555, 487.09157421408815, 495.1977795970551, 498.87777494514074, 499.6577344519016, 3968.305546529346, 4060.2488539620263, 4085.754854708727, 4134.875953721393, 4171.916561668811, 10880.891191087987, 11342.489587968561, 11381.430928453545, 11398.259113157617, 11404.657860264206, 10366.585336586451, 11121.110311175087, 11144.164187685956, 11151.609693660683, 11156.832647510293, 8657.047724750273, 8724.69463568772, 8771.342149338698, 8822.426542274732, 8824.470531768115, 5874.383189765013, 6099.390060994043, 6161.969190154021, 6270.4670103039925, 6289.96855015722, 9498.477583732962, 9888.752781180528, 10217.74455638615, 10229.693109206735, 10245.590176392861, 9152.17630413266, 9662.75843103928, 9922.355046921926, 10095.091441770275, 10114.342567733074, 8167.469114507538, 8375.036870759941, 8511.446755961091, 8523.275521580736, 8563.61463734146, 8561.57192140403, 8582.399232053696, 8626.698065567674, 8633.17984791469, 8670.0, 6489.707963141765, 7457.40340772726, 7608.619569021416, 7621.352185064332, 7736.806579835549, 7408.888666700038, 7433.814154645961, 7483.588402637907, 7626.428017898569, 7675.002249707502, 7124.180719217356, 7202.89195662076, 7207.891881621885, 7215.567065976058, 7234.493585448968, 4909.852704418873, 4962.305277261258, 5095.286659867547, 5166.974165129151, 5196.376434827845, 5076.162433198629, 5128.538431541179, 5173.92239116406, 5204.401493828107, 5261.684298942076], "value": 4700.634303194993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9045522026222, 339.80631040307037, 345.2025820354979, 351.1432105662184, 355.5466779855682, 6718.093057437244, 6726.091977583031, 6765.661716914153, 6821.351971562706, 6822.9765535169745, 5584.827186290873, 5867.88264234715, 6713.597184168953, 6721.462283017359, 6748.6625668716615, 4794.712317260967, 4877.70733755974, 4911.926321105187, 4944.258361245824, 4968.130577149002, 4888.0, 4961.677490963094, 4964.851054468371, 4989.476105008976, 5012.674176178537, 4272.739541835166, 4928.728919909404, 4977.601791856661, 4988.87527811804, 4995.150824359867, 4019.678425725935, 4572.451305843287, 4785.014219099087, 4892.046051020053, 4906.558409743105, 3600.459931010343, 4213.705040647156, 4237.724547904407, 4239.0, 4243.342281946272, 5570.442955704397, 6380.680965951684, 6401.847667419863, 6491.350864913518, 6501.284858665543, 5087.694738315713, 5627.8593035174445, 5904.114382842565, 5932.970335148297, 5944.7324870380935, 5941.316748573926, 7031.859362812766, 7162.856742865113, 7171.067761191064, 7192.388646965014, 4697.802060474592, 4756.881077973044, 4803.903921921542, 4828.903421931577, 4845.442774080991, 6450.193945695166, 7562.621868906588, 7565.773026809205, 7574.356179724675, 7579.052618422697, 4881.560659540658, 4911.336969509142, 4919.877003074952, 4925.7783399747095, 4926.014797040606, 4989.351384320015, 4992.975035124801, 4996.950030499721, 4999.150144475375, 5006.274090256965, 5037.647364684437, 5919.704014799243, 5936.495397891142, 5943.197668314722, 5955.880882382328, 6171.783987560503, 7199.820004499825, 7208.675609597581, 7214.0, 7223.9638801806705, 1621.3109428492844, 1663.2432243329256, 1663.3615888349966, 1667.8999260044436, 1668.1409074326732, 1006.2050979726081, 1047.3611097230682, 1049.4437947887632, 1067.1196263082988, 1078.3799315393524, 6606.636634985122, 6612.0, 6670.766523171763, 6671.566348187353, 6692.59844409337, 6048.637081775108, 7262.273772622695, 7407.222241664547, 7465.477416580788, 7477.0, 6060.757569697163, 6306.148669929593, 6816.352446517573, 6831.897521537181, 6832.111825462658, 3900.76595404271, 3945.723799334019, 3948.170884114311, 3958.050067983721, 3959.425883246913, 7513.4740568159705, 7838.568878711611, 7849.646765895548, 7852.136265010844, 7861.523620059663, 7650.655720492591, 7718.884216736754, 7721.112072111667, 7724.497907635986, 7739.92260077392, 6608.702608382634, 7499.987501687202, 7829.530228186327, 7835.412344074103, 7841.647125879349, 7205.423566114803, 7445.181030086795, 7464.888026679713, 7475.0656167979005, 7482.438817088631, 7327.926720732725, 7346.155192152971, 7364.705411783469, 7377.483576149618, 7383.630818459163, 6216.471599914058, 7741.032370953631, 7841.490303130278, 7842.882356764539, 7848.7645370638975, 4707.670463067552, 4774.474807771212, 4777.283407488904, 4782.832600858953, 4786.377770889762, 7178.8564228714085, 7407.703691852265, 7432.665530051268, 7452.329290363893, 7472.215417381097, 7136.643167841691, 7200.855982880418, 7210.567365958059, 7215.422766178588, 7219.819504512429, 7157.141143062866, 7161.21226665056, 7174.0, 7175.354218120394, 7187.6765545551625, 7035.47233957445, 7038.718451262097, 7040.436765058681, 7046.647667616701, 7059.929400705927, 5562.915231529812, 5823.534117270693, 7102.218755936739, 7185.461090418135, 7205.135383753983, 6710.496712746466, 6843.178818541807, 6868.656567171722, 6976.162860456575, 7011.509194356346], "value": 5212.591331663618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.3871612339203, 733.6588486353846, 746.1009483572296, 781.4686013510814, 785.195174945681, 15270.847291527081, 15456.995295305811, 15474.767878481833, 15480.458183963563, 15515.456959006437, 14188.0, 14350.354234059467, 14351.569452916428, 14351.784723229133, 14393.64015899603, 787.3071696906715, 805.0379796143611, 952.5618215620823, 986.7829077602952, 991.5538007896439, 961.1589858873485, 968.8788901387327, 973.3624475968252, 974.6393834281325, 980.9846808553149, 838.375410319313, 1035.0891215730185, 1039.6465201831377, 1040.6981975227175, 1040.9427481488515, 1024.4416792847878, 1057.8148823955778, 1059.9523021464054, 1060.6711919305, 1061.3950048472375, 793.4049462902823, 796.0765512006045, 797.4935915693518, 799.3844739550514, 800.6877317846045, 15252.38990440381, 15347.386104555804, 15355.539333820003, 15362.539123826304, 15364.0, 13240.271785051818, 13331.400086996011, 13484.123531970488, 13558.254296013716, 13575.185488870698, 9224.631014759469, 9950.402975821402, 9970.20238380935, 10080.193584513221, 10175.694729158136, 3015.336625942289, 3598.452665353897, 3605.080704420382, 3682.558093028827, 3703.185299234164, 81243.59378203072, 81829.0, 82307.0, 83831.0, 84200.57899710523, 9508.381955172892, 9522.666706665234, 9669.516524173763, 9849.310548261696, 9901.356411833207, 17474.825251747574, 21552.461188470414, 21886.781132188793, 21904.9047547622, 21936.45158871041, 7527.9084532742445, 7534.714995093865, 7759.495632783851, 7930.405219608552, 8005.799855003672, 4142.565030671736, 4200.369944508348, 4244.617984381421, 4245.27830268855, 4268.0, 3791.7156213284115, 3844.942325865114, 3856.421536769451, 3861.092643228839, 3867.3425517662067, 701.5930760159096, 704.6371118873784, 715.0561259137888, 715.3204455767042, 717.2612209424301, 542.8073034072926, 587.2600523340622, 610.8442347201524, 619.4486906653083, 636.9426751592334, 8013.078495972921, 8233.259006689426, 8244.670213191524, 8280.171982801792, 8309.529477108581, 511.3454777884314, 603.0833133636935, 632.3265722006141, 640.1102467570081, 643.1446176585224, 3507.5264839246884, 3715.1640880802142, 3876.8061596920043, 3913.5108111486065, 4069.2268468990796, 83431.58284208662, 88753.0, 89655.0, 90005.19989600171, 90320.0, 76007.0, 77091.0, 77110.0, 77351.61324193455, 79150.6042469784, 67100.0, 67356.6632166836, 67992.66003670049, 68386.31613683898, 70331.0, 7769.92230077692, 7791.64937577799, 7839.490433121829, 7864.5281283123195, 7918.604069796603, 48472.757636211594, 49976.0, 50066.74966625144, 50360.496395037044, 51144.488555113974, 59985.40014599973, 64819.703605926676, 68583.65708171428, 68725.0, 69464.0, 9985.750356241153, 10201.540930658286, 10251.948740256252, 10264.743381415525, 10389.84415233757, 10931.18016148776, 11071.225014248925, 11128.109751220045, 11225.494852731483, 11771.999380052792, 9718.271129665161, 9781.853272201066, 9914.23143127871, 10154.949225253826, 10209.591616335263, 10341.017603327671, 10419.462166597856, 10420.478976051016, 10431.739206519898, 10493.895061049292, 10066.748331291776, 10138.23963202748, 10145.898541014496, 10149.188064954933, 10704.571817127227, 8735.519546424754, 8895.154960278764, 8919.509058097441, 9031.0, 9062.728118156467, 8887.955560222157, 8921.687740929035, 9005.549722513717, 9112.498812565107, 9113.088691130833], "value": 6924.704955453096, "unit": "score"}], "name": "dromaeo_css", "value": 7573.8697247116215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 120.0, 112.0, 111.0, 110.0, 112.0, 113.0, 112.0, 133.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 146.0, 172.0, 162.0, 116.0, 145.0, 142.0, 178.0, 174.0, 116.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 186.0, 185.0, 184.0, 183.0, 185.0, 185.0, 186.0, 183.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 74.0, 154.0, 56.0, 55.0, 57.0, 65.0, 129.0, 55.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 177.0, 100.0, 79.0, 80.0, 122.0, 79.0, 76.0, 130.0], "value": 107.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 86.0, 89.0, 84.0, 89.0, 85.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 96.0, 102.0, 134.0, 147.0, 93.0, 93.0, 92.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 83.0, 84.0, 83.0, 85.0, 80.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 61.0, 62.0, 63.0, 62.0, 64.0, 79.0, 59.0, 56.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 77.0, 71.0, 69.0, 66.0, 69.0, 65.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 101.0, 101.0, 102.0, 69.0, 81.0, 99.0, 106.0, 108.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 134.0, 143.0, 125.0, 124.0, 124.0, 125.0, 143.0, 140.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 162.0, 164.0, 161.0, 163.0, 164.0, 165.0, 161.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 68.0, 67.0, 66.0, 66.0, 70.0, 85.0, 94.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1499.6000000000001, "alertThreshold": 2.0}]} 06:48:03 INFO - Return code: 0 06:48:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:48:04 ERROR - # TBPL SUCCESS # 06:48:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:04 INFO - 2016-07-14 06:48:04.062 screenresolution[1678:10155] starting screenresolution argv=screenresolution get 06:48:04 INFO - 2016-07-14 06:48:04.065 screenresolution[1678:10155] Display 0: 1600x1200x32@60 06:48:04 INFO - 2016-07-14 06:48:04.071 screenresolution[1679:10158] starting screenresolution argv=screenresolution list 06:48:04 INFO - Available Modes on Display 0 06:48:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:04 INFO - Intel Iris: 06:48:04 INFO - Chipset Model: Intel Iris 06:48:04 INFO - Type: GPU 06:48:04 INFO - Bus: Built-In 06:48:04 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:04 INFO - Vendor: Intel (0x8086) 06:48:04 INFO - Device ID: 0x0a2e 06:48:04 INFO - Revision ID: 0x0009 06:48:04 INFO - Displays: 06:48:04 INFO - Display: 06:48:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:04 INFO - Display Serial Number: 1600x1200 60 06:48:04 INFO - Main Display: Yes 06:48:04 INFO - Mirror: Off 06:48:04 INFO - Online: Yes 06:48:04 INFO - Rotation: Supported 06:48:04 INFO - Return code: 0 06:48:04 INFO - Running post-action listener: _resource_record_post_action 06:48:04 INFO - Running post-run listener: _resource_record_post_run 06:48:05 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37185024; Write bytes: 495066112; Read time: 250; Write time: 1560 06:48:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193430016; Write bytes: 185827328; Read time: 17822; Write time: 396 06:48:05 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35403264; Write bytes: 299494400; Read time: 236; Write time: 1135 06:48:05 INFO - Running post-run listener: _upload_blobber_files 06:48:05 INFO - Blob upload gear active. 06:48:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:05 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 06:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:06 INFO - (blobuploader) - INFO - Done attempting. 06:48:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:07 INFO - (blobuploader) - INFO - Done attempting. 06:48:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:07 INFO - Return code: 0 06:48:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f35c3dccdfe63f4f560129493a1f426fce6828ebfcfddf3917f06a480041c2c52f992791902d832da92bd7f4518b23eb9c3f8603f811c4e07d760a07465d7c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30ef963d968183f010fa9d892744b44df9eeb004b87bf24963e11da8be4693825fdd4300b17e6c90acd7f556dfd7d2979c7cea0b6898561bbe41e632ed5b6159"} 06:48:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:07 INFO - Contents: 06:48:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f35c3dccdfe63f4f560129493a1f426fce6828ebfcfddf3917f06a480041c2c52f992791902d832da92bd7f4518b23eb9c3f8603f811c4e07d760a07465d7c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30ef963d968183f010fa9d892744b44df9eeb004b87bf24963e11da8be4693825fdd4300b17e6c90acd7f556dfd7d2979c7cea0b6898561bbe41e632ed5b6159"} 06:48:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:07 INFO - Copying logs to upload dir... 06:48:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.714355 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-14 06:48:07.886708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:48:07.890455) ========= 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.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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-Beta/sha512/f35c3dccdfe63f4f560129493a1f426fce6828ebfcfddf3917f06a480041c2c52f992791902d832da92bd7f4518b23eb9c3f8603f811c4e07d760a07465d7c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30ef963d968183f010fa9d892744b44df9eeb004b87bf24963e11da8be4693825fdd4300b17e6c90acd7f556dfd7d2979c7cea0b6898561bbe41e632ed5b6159"} build_url:https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/A27YP7AzQbKGjK1dro8F5Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f35c3dccdfe63f4f560129493a1f426fce6828ebfcfddf3917f06a480041c2c52f992791902d832da92bd7f4518b23eb9c3f8603f811c4e07d760a07465d7c86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30ef963d968183f010fa9d892744b44df9eeb004b87bf24963e11da8be4693825fdd4300b17e6c90acd7f556dfd7d2979c7cea0b6898561bbe41e632ed5b6159"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:48:07.923875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:48:07.924303) ========= 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.reaMUMWi3K/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.38iJRoAdl2/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.005073 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:48:07.973774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:48:07.974112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:48:07.974442) ========= ========= Total master_lag: 0.17 =========