builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1462798483.17 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.172982) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.173490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.173772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.191278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.191606) ========= 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.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-05-09 05:54:43-- 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% 65.4M=0s 2016-05-09 05:54:43 (65.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.354918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.355277) ========= 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.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.019730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:43.404246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 05:54:43.404585) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-05-09 05:54:43,481 truncating revision to first 12 chars 2016-05-09 05:54:43,481 Setting DEBUG logging. 2016-05-09 05:54:43,481 attempt 1/10 2016-05-09 05:54:43,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:54:44,908 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.667879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 05:54:45.089541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:45.089859) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:45.090303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:45.090607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:45.103966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-09 05:54:45.104296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:54:45 INFO - MultiFileLogger online at 20160509 05:54:45 in /builds/slave/test 05:54:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:54:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:45 INFO - {'append_to_log': False, 05:54:45 INFO - 'base_work_dir': '/builds/slave/test', 05:54:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:54:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:45 INFO - 'branch': 'Mozilla-Aurora', 05:54:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:45 INFO - 'config_files': ('talos/mac_config.py',), 05:54:45 INFO - 'default_actions': ('clobber', 05:54:45 INFO - 'read-buildbot-config', 05:54:45 INFO - 'download-and-extract', 05:54:45 INFO - 'populate-webroot', 05:54:45 INFO - 'create-virtualenv', 05:54:45 INFO - 'install', 05:54:45 INFO - 'run-tests'), 05:54:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:45 INFO - 'download_minidump_stackwalk': True, 05:54:45 INFO - 'download_symbols': 'ondemand', 05:54:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:45 INFO - 'installer_path': 'installer.exe', 05:54:45 INFO - 'log_level': 'info', 05:54:45 INFO - 'log_name': 'talos', 05:54:45 INFO - 'log_to_console': True, 05:54:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:45 INFO - 'opt_config_files': (), 05:54:45 INFO - 'pip_index': False, 05:54:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:45 INFO - 'cmd': ('bash', 05:54:45 INFO - '-c', 05:54:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:45 INFO - 'enabled': True, 05:54:45 INFO - 'halt_on_failure': False, 05:54:45 INFO - 'name': 'check_screen_resolution'},), 05:54:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:45 INFO - 'cmd': ('bash', 05:54:45 INFO - '-c', 05:54:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:45 INFO - 'enabled': True, 05:54:45 INFO - 'halt_on_failure': False, 05:54:45 INFO - 'name': 'check_screen_resolution'},), 05:54:45 INFO - 'run_cmd_checks_enabled': True, 05:54:45 INFO - 'sps_profile': False, 05:54:45 INFO - 'sps_profile_interval': 0, 05:54:45 INFO - 'suite': 'dromaeojs', 05:54:45 INFO - 'system_bits': '32', 05:54:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:45 INFO - 'title': 't-yosemite-r7-0106', 05:54:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:45 INFO - 'use_talos_json': True, 05:54:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:45 INFO - 'work_dir': 'build'} 05:54:45 INFO - ##### 05:54:45 INFO - ##### Running clobber step. 05:54:45 INFO - ##### 05:54:45 INFO - Running pre-action listener: _resource_record_pre_action 05:54:45 INFO - Running main action method: clobber 05:54:45 INFO - rmtree: /builds/slave/test/build 05:54:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running read-buildbot-config step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: read_buildbot_config 05:54:46 INFO - Using buildbot properties: 05:54:46 INFO - { 05:54:46 INFO - "project": "", 05:54:46 INFO - "product": "firefox", 05:54:46 INFO - "script_repo_revision": "production", 05:54:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:54:46 INFO - "repository": "", 05:54:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:54:46 INFO - "buildid": "20160509005049", 05:54:46 INFO - "pgo_build": "False", 05:54:46 INFO - "basedir": "/builds/slave/test", 05:54:46 INFO - "buildnumber": 1, 05:54:46 INFO - "slavename": "t-yosemite-r7-0106", 05:54:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:54:46 INFO - "platform": "yosemite_r7", 05:54:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:54:46 INFO - "branch": "mozilla-aurora", 05:54:46 INFO - "repo_path": "releases/mozilla-aurora", 05:54:46 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 05:54:46 INFO - "stage_platform": "macosx64", 05:54:46 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 05:54:46 INFO - "slavebuilddir": "test" 05:54:46 INFO - } 05:54:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 05:54:46 INFO - Running post-action listener: _resource_record_post_action 05:54:46 INFO - ##### 05:54:46 INFO - ##### Running download-and-extract step. 05:54:46 INFO - ##### 05:54:46 INFO - Running pre-action listener: _resource_record_pre_action 05:54:46 INFO - Running main action method: download_and_extract 05:54:46 INFO - mkdir: /builds/slave/test/build/tests 05:54:46 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')]} 05:54:46 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 05:54:47 INFO - Downloaded 1199 bytes. 05:54:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:47 INFO - Using the following test package requirements: 05:54:47 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:47 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 05:54:47 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 05:54:47 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'jsshell-mac.zip'], 05:54:47 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 05:54:47 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:47 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 05:54:47 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 05:54:47 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 05:54:47 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:47 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 05:54:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:54:47 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:53 INFO - Downloaded 18088795 bytes. 05:54:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:54:56 INFO - Return code: 0 05:54:56 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:56 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')]} 05:54:56 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:58 INFO - Downloaded 18088795 bytes. 05:54:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:55:02 INFO - Return code: 0 05:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:02 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:55:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:55:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:55:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:55:03 INFO - Downloaded 10840145 bytes. 05:55:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:55:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:55:03 INFO - Return code: 0 05:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:03 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:55:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:55:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:55:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 05:55:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 05:55:06 INFO - Downloaded 114085322 bytes. 05:55:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:55:06 INFO - mkdir: /builds/slave/test/properties 05:55:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:06 INFO - Contents: 05:55:06 INFO - build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:55:07 INFO - Running post-action listener: _resource_record_post_action 05:55:07 INFO - Running post-action listener: set_extra_try_arguments 05:55:07 INFO - ##### 05:55:07 INFO - ##### Running populate-webroot step. 05:55:07 INFO - ##### 05:55:07 INFO - Running pre-action listener: _resource_record_pre_action 05:55:07 INFO - Running main action method: populate_webroot 05:55:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:07 INFO - '--tppagecycles', 05:55:07 INFO - '7'], 05:55:07 INFO - 'tests': ['tsvgm']}}, 05:55:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['damp', 'tps']}, 05:55:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'tests': ['damp', 'tps']}, 05:55:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['dromaeo_dom']}, 05:55:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['a11yr', 05:55:07 INFO - 'ts_paint', 05:55:07 INFO - 'tpaint', 05:55:07 INFO - 'sessionrestore', 05:55:07 INFO - 'sessionrestore_no_auto_restore', 05:55:07 INFO - 'tabpaint']}, 05:55:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['tsvgx', 05:55:07 INFO - 'tsvgr_opacity', 05:55:07 INFO - 'tart', 05:55:07 INFO - 'tscrollx', 05:55:07 INFO - 'cart']}, 05:55:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:07 INFO - 'tsvgr_opacity', 05:55:07 INFO - 'tart', 05:55:07 INFO - 'tscrollx', 05:55:07 INFO - 'cart']}, 05:55:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'talos_options': ['--disable-e10s'], 05:55:07 INFO - 'tests': ['tp5o']}, 05:55:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'tests': ['tp5o']}, 05:55:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'talos_options': ['--disable-e10s', 05:55:07 INFO - '--xperf_path', 05:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:07 INFO - 'tests': ['tp5n']}, 05:55:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:07 INFO - 'talos_options': ['--xperf_path', 05:55:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:07 INFO - 'tests': ['tp5n']}}, 05:55:07 INFO - 'talos.zip': {'path': '', 05:55:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:07 INFO - Running post-action listener: _resource_record_post_action 05:55:07 INFO - ##### 05:55:07 INFO - ##### Running create-virtualenv step. 05:55:07 INFO - ##### 05:55:07 INFO - Running pre-action listener: _resource_record_pre_action 05:55:07 INFO - Running main action method: create_virtualenv 05:55:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:07 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 05:55:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:07 INFO - Using real prefix '/tools/python27' 05:55:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:10 INFO - Installing pip.................done. 05:55:10 INFO - Return code: 0 05:55:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:10 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')]} 05:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:10 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')]} 05:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:10 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:10 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 05:55:10 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 05:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:10 INFO - 'HOME': '/Users/cltbld', 05:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:10 INFO - 'LOGNAME': 'cltbld', 05:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:10 INFO - 'MOZ_NO_REMOTE': '1', 05:55:10 INFO - 'NO_EM_RESTART': '1', 05:55:10 INFO - 'PAGER': '/bin/cat', 05:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:10 INFO - 'PWD': '/builds/slave/test', 05:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:10 INFO - 'SHELL': '/bin/bash', 05:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:10 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:10 INFO - 'USER': 'cltbld', 05:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:10 INFO - 'XPC_FLAGS': '0x0', 05:55:10 INFO - 'XPC_SERVICE_NAME': '0', 05:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:11 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 05:55:11 INFO - Cleaning up... 05:55:11 INFO - Return code: 0 05:55:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:55:11 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')]} 05:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:11 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')]} 05:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:11 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:11 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 05:55:11 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 05:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:11 INFO - 'HOME': '/Users/cltbld', 05:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:11 INFO - 'LOGNAME': 'cltbld', 05:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:11 INFO - 'MOZ_NO_REMOTE': '1', 05:55:11 INFO - 'NO_EM_RESTART': '1', 05:55:11 INFO - 'PAGER': '/bin/cat', 05:55:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:11 INFO - 'PWD': '/builds/slave/test', 05:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:11 INFO - 'SHELL': '/bin/bash', 05:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:11 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:11 INFO - 'USER': 'cltbld', 05:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:11 INFO - 'XPC_FLAGS': '0x0', 05:55:11 INFO - 'XPC_SERVICE_NAME': '0', 05:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:11 INFO - Downloading/unpacking psutil>=0.7.1 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:11 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 05:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:14 INFO - Installing collected packages: psutil 05:55:14 INFO - Running setup.py install for psutil 05:55:14 INFO - building 'psutil._psutil_osx' extension 05:55:14 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 05:55:14 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 05:55:14 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 05:55:14 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 05:55:14 INFO - building 'psutil._psutil_posix' extension 05:55:14 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 05:55:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:55:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:55:14 INFO - ^ 05:55:14 INFO - 1 warning generated. 05:55:14 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 05:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:14 INFO - Successfully installed psutil 05:55:14 INFO - Cleaning up... 05:55:14 INFO - Return code: 0 05:55:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:14 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:14 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 05:55:14 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 05:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:14 INFO - 'HOME': '/Users/cltbld', 05:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:14 INFO - 'LOGNAME': 'cltbld', 05:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:14 INFO - 'MOZ_NO_REMOTE': '1', 05:55:14 INFO - 'NO_EM_RESTART': '1', 05:55:14 INFO - 'PAGER': '/bin/cat', 05:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:14 INFO - 'PWD': '/builds/slave/test', 05:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:14 INFO - 'SHELL': '/bin/bash', 05:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:14 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:14 INFO - 'USER': 'cltbld', 05:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:14 INFO - 'XPC_FLAGS': '0x0', 05:55:14 INFO - 'XPC_SERVICE_NAME': '0', 05:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:55:15 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 05:55:15 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 05:55:15 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 05:55:15 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 05:55:15 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 05:55:15 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 05:55:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:55:17 INFO - Installing collected packages: mozsystemmonitor 05:55:17 INFO - Running setup.py install for mozsystemmonitor 05:55:17 INFO - Successfully installed mozsystemmonitor 05:55:17 INFO - Cleaning up... 05:55:17 INFO - Return code: 0 05:55:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55:17 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')]} 05:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:17 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')]} 05:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:17 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:17 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 05:55:17 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 05:55:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:17 INFO - 'HOME': '/Users/cltbld', 05:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:17 INFO - 'LOGNAME': 'cltbld', 05:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:17 INFO - 'MOZ_NO_REMOTE': '1', 05:55:17 INFO - 'NO_EM_RESTART': '1', 05:55:17 INFO - 'PAGER': '/bin/cat', 05:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:17 INFO - 'PWD': '/builds/slave/test', 05:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:17 INFO - 'SHELL': '/bin/bash', 05:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:17 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:17 INFO - 'USER': 'cltbld', 05:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:17 INFO - 'XPC_FLAGS': '0x0', 05:55:17 INFO - 'XPC_SERVICE_NAME': '0', 05:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:18 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 05:55:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:20 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 05:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:21 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 05:55:21 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 05:55:21 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 05:55:21 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 05:55:21 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 05:55:21 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 05:55:21 INFO - Downloading docopt-0.6.1.tar.gz 05:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:21 INFO - Running setup.py install for blobuploader 05:55:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:21 INFO - Running setup.py install for requests 05:55:22 INFO - Running setup.py install for docopt 05:55:22 INFO - Successfully installed blobuploader requests docopt 05:55:22 INFO - Cleaning up... 05:55:22 INFO - Return code: 0 05:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:22 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')]} 05:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 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')]} 05:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:22 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 05:55:22 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 05:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:22 INFO - 'HOME': '/Users/cltbld', 05:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:22 INFO - 'LOGNAME': 'cltbld', 05:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:22 INFO - 'MOZ_NO_REMOTE': '1', 05:55:22 INFO - 'NO_EM_RESTART': '1', 05:55:22 INFO - 'PAGER': '/bin/cat', 05:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:22 INFO - 'PWD': '/builds/slave/test', 05:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:22 INFO - 'SHELL': '/bin/bash', 05:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:22 INFO - 'USER': 'cltbld', 05:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:22 INFO - 'XPC_FLAGS': '0x0', 05:55:22 INFO - 'XPC_SERVICE_NAME': '0', 05:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-GEOeBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-dP0OcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hnjVX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-PvxkQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-4q3BkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HSvszm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0uBcrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Aqorza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-QHYLLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-58kzyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:23 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Es284X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-b4CRxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Apu6KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-pLGnWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-KiLEJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Um9Dbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:24 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ig8UqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:24 INFO - Running setup.py install for manifestparser 05:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozcrash 05:55:24 INFO - Running setup.py install for mozdebug 05:55:25 INFO - Running setup.py install for mozdevice 05:55:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Running setup.py install for mozfile 05:55:25 INFO - Running setup.py install for mozhttpd 05:55:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Running setup.py install for mozinfo 05:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Running setup.py install for mozInstall 05:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Running setup.py install for mozleak 05:55:26 INFO - Running setup.py install for mozlog 05:55:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Running setup.py install for moznetwork 05:55:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Running setup.py install for mozprocess 05:55:26 INFO - Running setup.py install for mozprofile 05:55:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Running setup.py install for mozrunner 05:55:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:26 INFO - Running setup.py install for mozscreenshot 05:55:26 INFO - Running setup.py install for moztest 05:55:27 INFO - Running setup.py install for mozversion 05:55:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:27 INFO - Cleaning up... 05:55:27 INFO - Return code: 0 05:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:27 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:27 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 05:55:27 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 05:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:27 INFO - 'HOME': '/Users/cltbld', 05:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:27 INFO - 'LOGNAME': 'cltbld', 05:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:27 INFO - 'MOZ_NO_REMOTE': '1', 05:55:27 INFO - 'NO_EM_RESTART': '1', 05:55:27 INFO - 'PAGER': '/bin/cat', 05:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:27 INFO - 'PWD': '/builds/slave/test', 05:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:27 INFO - 'SHELL': '/bin/bash', 05:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:27 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:27 INFO - 'USER': 'cltbld', 05:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:27 INFO - 'XPC_FLAGS': '0x0', 05:55:27 INFO - 'XPC_SERVICE_NAME': '0', 05:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-SGDxzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:27 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)) 05:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-faqMl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:27 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)) 05:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-tvD0yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:27 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)) 05:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-qTJSY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:27 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)) 05:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5jkldy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kiby4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-a9gqxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zH7Hh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ISLmMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6jImQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-pEAxrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-mi4ZFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2u_kYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:28 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)) 05:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Gyt3re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:29 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)) 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-15Bn4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:29 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)) 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-BuAazf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:29 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)) 05:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-N0MkEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 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)) 05:55:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:29 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 05:55:29 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 05:55:29 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 05:55:29 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 05:55:29 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 05:55:29 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 05:55:31 INFO - Downloading blessings-1.6.tar.gz 05:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:31 INFO - Installing collected packages: blessings 05:55:31 INFO - Running setup.py install for blessings 05:55:31 INFO - Successfully installed blessings 05:55:31 INFO - Cleaning up... 05:55:32 INFO - Return code: 0 05:55:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:32 INFO - Reading from file tmpfile_stdout 05:55:32 INFO - Current package versions: 05:55:32 INFO - blessings == 1.6 05:55:32 INFO - blobuploader == 1.2.4 05:55:32 INFO - docopt == 0.6.1 05:55:32 INFO - manifestparser == 1.1 05:55:32 INFO - mozInstall == 1.12 05:55:32 INFO - mozcrash == 0.17 05:55:32 INFO - mozdebug == 0.1 05:55:32 INFO - mozdevice == 0.48 05:55:32 INFO - mozfile == 1.2 05:55:32 INFO - mozhttpd == 0.7 05:55:32 INFO - mozinfo == 0.9 05:55:32 INFO - mozleak == 0.1 05:55:32 INFO - mozlog == 3.1 05:55:32 INFO - moznetwork == 0.27 05:55:32 INFO - mozprocess == 0.22 05:55:32 INFO - mozprofile == 0.28 05:55:32 INFO - mozrunner == 6.11 05:55:32 INFO - mozscreenshot == 0.1 05:55:32 INFO - mozsystemmonitor == 0.0 05:55:32 INFO - moztest == 0.7 05:55:32 INFO - mozversion == 1.4 05:55:32 INFO - psutil == 3.1.1 05:55:32 INFO - requests == 1.2.3 05:55:32 INFO - wsgiref == 0.1.2 05:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:32 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:32 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 05:55:32 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 05:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:32 INFO - 'HOME': '/Users/cltbld', 05:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:32 INFO - 'LOGNAME': 'cltbld', 05:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:32 INFO - 'MOZ_NO_REMOTE': '1', 05:55:32 INFO - 'NO_EM_RESTART': '1', 05:55:32 INFO - 'PAGER': '/bin/cat', 05:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:32 INFO - 'PWD': '/builds/slave/test', 05:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:32 INFO - 'SHELL': '/bin/bash', 05:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:32 INFO - 'USER': 'cltbld', 05:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:32 INFO - 'XPC_FLAGS': '0x0', 05:55:32 INFO - 'XPC_SERVICE_NAME': '0', 05:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 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)) 05:55:32 INFO - Cleaning up... 05:55:32 INFO - Return code: 0 05:55:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:32 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:32 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 05:55:32 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 05:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:32 INFO - 'HOME': '/Users/cltbld', 05:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:32 INFO - 'LOGNAME': 'cltbld', 05:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:32 INFO - 'MOZ_NO_REMOTE': '1', 05:55:32 INFO - 'NO_EM_RESTART': '1', 05:55:32 INFO - 'PAGER': '/bin/cat', 05:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:32 INFO - 'PWD': '/builds/slave/test', 05:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:32 INFO - 'SHELL': '/bin/bash', 05:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:32 INFO - 'USER': 'cltbld', 05:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:32 INFO - 'XPC_FLAGS': '0x0', 05:55:32 INFO - 'XPC_SERVICE_NAME': '0', 05:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:32 INFO - Downloading/unpacking jsonschema 05:55:32 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 05:55:32 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 05:55:32 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 05:55:32 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 05:55:32 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 05:55:32 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 05:55:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:35 INFO - Downloading/unpacking functools32 (from jsonschema) 05:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:35 INFO - warning: no files found matching '*.txt' 05:55:35 INFO - no previously-included directories found matching 'build' 05:55:35 INFO - no previously-included directories found matching 'dist' 05:55:35 INFO - no previously-included directories found matching '.git*' 05:55:35 INFO - Installing collected packages: jsonschema, functools32 05:55:35 INFO - Running setup.py install for functools32 05:55:36 INFO - warning: no files found matching '*.txt' 05:55:36 INFO - no previously-included directories found matching 'build' 05:55:36 INFO - no previously-included directories found matching 'dist' 05:55:36 INFO - no previously-included directories found matching '.git*' 05:55:36 INFO - Successfully installed jsonschema functools32 05:55:36 INFO - Cleaning up... 05:55:36 INFO - Return code: 0 05:55:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:36 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 0x102e88a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e98420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb358da0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, '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.iJg1VmgR4b/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.SM52hbTzh9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 05:55:36 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 05:55:36 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 05:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:36 INFO - 'HOME': '/Users/cltbld', 05:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:36 INFO - 'LOGNAME': 'cltbld', 05:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:36 INFO - 'MOZ_NO_REMOTE': '1', 05:55:36 INFO - 'NO_EM_RESTART': '1', 05:55:36 INFO - 'PAGER': '/bin/cat', 05:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:36 INFO - 'PWD': '/builds/slave/test', 05:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:36 INFO - 'SHELL': '/bin/bash', 05:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:55:36 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:36 INFO - 'USER': 'cltbld', 05:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:36 INFO - 'XPC_FLAGS': '0x0', 05:55:36 INFO - 'XPC_SERVICE_NAME': '0', 05:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:36 INFO - Downloading/unpacking flake8 05:55:36 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 05:55:36 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 05:55:36 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 05:55:36 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 05:55:36 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 05:55:36 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 05:55:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:55:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:55:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:39 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 05:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:40 INFO - no previously-included directories found matching 'docs/_build' 05:55:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:55:40 INFO - Running setup.py install for pep8 05:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:55:40 INFO - no previously-included directories found matching 'docs/_build' 05:55:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:55:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:55:40 INFO - Cleaning up... 05:55:40 INFO - Return code: 0 05:55:40 INFO - Running post-action listener: _resource_record_post_action 05:55:40 INFO - Running post-action listener: _start_resource_monitoring 05:55:40 INFO - Starting resource monitoring. 05:55:40 INFO - ##### 05:55:40 INFO - ##### Running install step. 05:55:40 INFO - ##### 05:55:40 INFO - Running pre-action listener: _resource_record_pre_action 05:55:40 INFO - Running main action method: install 05:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:40 INFO - Reading from file tmpfile_stdout 05:55:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:40 INFO - Reading from file tmpfile_stdout 05:55:40 INFO - Output received: 05:55:40 INFO - Usage: mozinstall [options] installer 05:55:40 INFO - Options: 05:55:40 INFO - -h, --help show this help message and exit 05:55:40 INFO - -d DEST, --destination=DEST 05:55:40 INFO - Directory to install application into. [default: 05:55:40 INFO - "/builds/slave/test"] 05:55:40 INFO - --app=APP Application being installed. [default: firefox] 05:55:40 INFO - mkdir: /builds/slave/test/build/application 05:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:56:12 INFO - Reading from file tmpfile_stdout 05:56:12 INFO - Output received: 05:56:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:56:12 INFO - Running post-action listener: _resource_record_post_action 05:56:12 INFO - ##### 05:56:12 INFO - ##### Running run-tests step. 05:56:12 INFO - ##### 05:56:12 INFO - Running pre-action listener: _resource_record_pre_action 05:56:12 INFO - Running main action method: run_tests 05:56:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:12 INFO - 2016-05-09 05:56:12.515 screenresolution[1980:13391] starting screenresolution argv=screenresolution get 05:56:12 INFO - 2016-05-09 05:56:12.518 screenresolution[1980:13391] Display 0: 1600x1200x32@60 05:56:12 INFO - 2016-05-09 05:56:12.523 screenresolution[1981:13393] starting screenresolution argv=screenresolution list 05:56:12 INFO - Available Modes on Display 0 05:56:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:12 INFO - Intel Iris: 05:56:12 INFO - Chipset Model: Intel Iris 05:56:12 INFO - Type: GPU 05:56:12 INFO - Bus: Built-In 05:56:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:12 INFO - Vendor: Intel (0x8086) 05:56:12 INFO - Device ID: 0x0a2e 05:56:12 INFO - Revision ID: 0x0009 05:56:12 INFO - Displays: 05:56:12 INFO - Display: 05:56:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:12 INFO - Display Serial Number: 1600x1200 60 05:56:12 INFO - Main Display: Yes 05:56:12 INFO - Mirror: Off 05:56:12 INFO - Online: Yes 05:56:12 INFO - Rotation: Supported 05:56:12 INFO - Return code: 0 05:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:56:12 INFO - Python 2.7.3 05:56:12 INFO - Return code: 0 05:56:12 INFO - grabbing minidump binary from tooltool 05:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:56:12 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 0x102d27e00>, '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 0x102b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d22b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:56:12 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 05:56:12 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 05:56:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:56:12 INFO - Return code: 0 05:56:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:56:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:56:13 INFO - Return code: 0 05:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 05:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iJg1VmgR4b/Render', 05:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:13 INFO - 'HOME': '/Users/cltbld', 05:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:13 INFO - 'LOGNAME': 'cltbld', 05:56:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:56:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:13 INFO - 'MOZ_NO_REMOTE': '1', 05:56:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:56:13 INFO - 'NO_EM_RESTART': '1', 05:56:13 INFO - 'PAGER': '/bin/cat', 05:56:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:13 INFO - 'PWD': '/builds/slave/test', 05:56:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:13 INFO - 'SHELL': '/bin/bash', 05:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SM52hbTzh9/Listeners', 05:56:13 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:13 INFO - 'USER': 'cltbld', 05:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:13 INFO - 'XPC_FLAGS': '0x0', 05:56:13 INFO - 'XPC_SERVICE_NAME': '0', 05:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:56:14 INFO - mozversion application_buildid: 20160509005049 05:56:14 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:56:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:56:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:56:14 INFO - mozversion application_name: Firefox 05:56:14 INFO - mozversion application_remotingname: firefox-dev 05:56:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:56:14 INFO - mozversion application_vendor: Mozilla 05:56:14 INFO - mozversion application_version: 48.0a2 05:56:14 INFO - mozversion platform_buildid: 20160509005049 05:56:14 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:56:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:56:14 INFO - mozversion platform_version: 48.0a2 05:56:14 INFO - using testdate: 1462798574 05:56:14 INFO - actual date: 1462798574 05:56:14 INFO - starting webserver on 'localhost:49581' 05:56:14 INFO - SUITE-START | Running 2 tests 05:56:14 INFO - TEST-START | dromaeo_css 05:56:14 INFO - operating with platform_type : mac_ 05:56:14 INFO - Initialising browser for dromaeo_css test... 05:56:14 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpgvas8h/profile http://localhost:49581/getInfo.html) 05:56:16 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 05:56:16 INFO - PROCESS | 1999 | colorDepth:24 05:56:16 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 05:56:16 INFO - PROCESS | 1999 | __metrics 05:56:16 INFO - PROCESS | 1999 | 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" 05:56:16 ERROR - PROCESS | 1999 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:56:17 INFO - TEST-INFO | 1999: exit 0 05:56:17 INFO - Browser initialized. 05:56:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:56:17 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpgvas8h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:29 INFO - PROCESS | 2001 | RSS: Main: 210337792 05:56:29 INFO - PROCESS | 2001 | 05:57:21 INFO - PROCESS | 2001 | 1462798641083 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] 05:59:31 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49581/tests/dromaeo/cssquery-ext.html) 05:59:32 INFO - PROCESS | 2001 | RSS: Main: 306450432 05:59:32 INFO - PROCESS | 2001 | 06:02:35 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-ext.html (next: http://localhost:49581/tests/dromaeo/cssquery-jquery.html) 06:02:36 INFO - PROCESS | 2001 | RSS: Main: 358215680 06:02:36 INFO - PROCESS | 2001 | 06:05:38 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49581/tests/dromaeo/cssquery-mootools.html) 06:05:39 INFO - PROCESS | 2001 | RSS: Main: 359378944 06:05:39 INFO - PROCESS | 2001 | 06:08:41 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49581/tests/dromaeo/cssquery-prototype.html) 06:08:41 INFO - PROCESS | 2001 | RSS: Main: 361668608 06:08:41 INFO - PROCESS | 2001 | 06:11:45 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49581/tests/dromaeo/cssquery-yui.html) 06:11:45 INFO - PROCESS | 2001 | RSS: Main: 328380416 06:11:45 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49581/tests/dromaeo/cssquery-yui.html (next: http://localhost:49581/tests/dromaeo/cssquery-dojo.html) 06:14:48 INFO - PROCESS | 2001 | RSS: Main: 382545920 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | __start_tp_report 06:14:48 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 06:14:48 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 06:14:48 INFO - PROCESS | 2001 | |i|pagename|runs| 06:14:48 INFO - PROCESS | 2001 | |0;dojo.html;3418.418868792305;3483.494893240482;3508.1580420699024;3531.4702794580826;3555.2000799820025;5820.621659592129;5835.358110607835;5840.415958404168;5843.035899076658;5905.557083218754;5860.912086318709;5864.472197502224;5885.234919460475;5887.116932460122;5895.4399332063385;5201.5838732901275;5274.156135018388;5296.285001524783;5335.653182543142;5413.702246376448;5347.812826551071;5363.490468405515;5374.6237763356585;5375.0593646111965;5378.569714422837;5314.335708036496;5331.760070796804;5353.652012619187;5355.892882142355;5365.678059316434;5308.601854860901;5333.573314134898;5345.5990800689715;5346.304980352568;5365.678059316453;5132.563732082777;5214.8696282592855;5249.947500524984;5280.3663560372615;5289.365276166846;5633.211350410946;5659.490645841894;5717.456841600041;5728.770849166029;5764;6282.151909492206;6302.243730752339;6308.148399966038;6329.8417539561415;6336.429721325103;6200.565960382775;6217.813465596039;6285.277193122758;6291.402316779899;6301.306856245809;5940.970295148497;5960.493358064569;5961.135635332853;5974.253218347707;5979.970100149471;6321.873562528724;6332.303446620868;6343.460805831556;6347.365263473708;6347.904781428282;5273.841784746463;6142.437386315926;6210;6279.686015699197;6298.968505157445;6252.374762523802;6260.906086408708;6269.937300627026;6281.3404592518045;6287.339829317947;6304.65324407162;6308.810735677937;6320.367963203643;6328.746850125944;6333.113364129025;6153.923063463965;6219.47134493564;6313.55805093639;6327.841803954846;6342.873142537216;4958.330625365529;4997.575206107449;5010.724410157403;5014.047331007097;5029.0947629427055;4499.145162419195;4512.300593408027;4517.435320584927;4543.613792827647;4551.431071116111;5652.378238393773;5740.770369185186;5774.2782152230975;5856.121581762684;5858.619189752652;5824;5847.918135145012;6255.499560035186;6273.278572964076;6292.528060395397;5772.7690892363835;5798.5071268941765;5804.535637149018;5806.79676211339;5816.127580862904;5422.783088676488;5447.073997420448;5452.781888724486;5499.835004949858;5513.338399392019;6326.841828954313;6393.904091438632;6406.775762848278;6409.743610255631;6438.066480360415;6251.499880009679;6274;6287.088372186099;6292.11910332563;6292.465140463112;6270.623762574078;6320.873582528232;6368.140301059298;6397.744090236524;6407.070974708734;6237.563370564017;6244.0321750128805;6246.812595622138;6256.343083976117;6278.686065696788;6260.123582698517;6281.874362512815;6305.558610897377;6308.653024083719;6343.682815859281;6113.694315284307;6180.567360284737;6213.254409470893;6246.156768836149;6291.811245662638;6181.412765787423;6249.531285153723;6257.499400047895;6270.529710271657;6283.02613094971;5436.238926550207;5933.881322373442;6082.057281121433;6094.786682466092;6127.877442451215;5871.442212989759;6171.5988460751705;6263.592866463665;6264.718087686157;6282.403171698681;6098.75604975796;6113.174721412553;6123.785667501616;6135.049067394561;6141.07883817431 06:14:48 INFO - PROCESS | 2001 | |1;ext.html;510.6017306500929;522.754305476426;526.6129394894751;582.8688545077357;584.0596639410551;30898.382032359368;31476.842615786918;38463.846084617435;38879.41680874789;38891.611083889155;41675.16649667012;42058.57941420585;42136.15727685452;42171.94570135748;42173;8426.452280601741;8489.363297752663;9480.431174129557;9785.315027948047;9794.510274486247;7426.480146389755;8700.216980471756;8701.912980870173;10002.849957250646;11555.768884622303;11496;11534.365609891494;11536.826947595793;11568.884311156908;11570;11477.426128693574;11545.53817847285;11550.53797848085;11552.422378881107;11596.362200078993;8646.783830404227;11500.367479788609;11670.299782013106;11695.005924496429;11704.824427633592;31400.528992065138;38052.619473805185;38423.807880960696;38443.23113537714;38454.03864903372;3174.873005079794;3176.5076413156;3214.6624604416434;3304.7190988765983;3333.4666453367345;27053.86473067622;27067;27266.182014539594;27920;28425.147245582666;2628.8028397870235;2650.801189910745;2707.7969152313653;2707.9323016924536;2738.931526711828;472853;473488.99999999657;473568;473849;477598;36165.63834361623;63294.36705632977;63976.68011659912;63988;63997.36002640007;35574;35732.464013039826;35767.82116089455;35787;35844.92465226047;15754;16037;16052.438164664414;16078.75881861773;16082.758758618631;12253;13478;13576.728465430833;13602.93198534001;13613.523526676718;7522.134954480195;7599.734009309647;7604.163542010375;7607.619619019027;8166.469179503313;2875;3370.3259348130473;3376.442886923679;3376.493525971124;3406.0633325835097;899.635647562725;945;959.9808003839884;1069.7379142110233;1071.2447724354467;24688.259352219462;29753.10740677783;29880;29963.368137756;30153.698463015528;980.4656462228103;990.9009099090033;1069.3049517813329;1095.2388090277182;1097.9341239525654;15034.398624055135;15820.129892855774;15829.920850395674;16218.945768525007;16379.0172589645;630596;634327.455264505;636771.8161409163;637498;638962;61335.38664613386;61638.0754288686;61654.383456165764;61797.69101154465;61864.38135618586;1456.2427537680558;1486.2271618757968;1504.428317239464;1504.5411149599477;1508.1328236264192;29812;29868.402631947672;30232;30936.53595196119;31044.68955310418;54504.45495544994;54520;55222;55383;55480.44519554753;540268;550157;551726;552141;554943;42573.148537028464;43445;43746.781266093465;43939.78030109829;43987.56012439963;42610.360844586736;46661.766691167686;47118.52881471279;47129.52870471252;47711;35014.64985350114;37207.6279237215;37383.81308093442;37934.86195414142;37996;36555.08612284714;36682.816585917964;36830.63169368379;37428;37548;37370.626293737805;37612.81193594124;37745.81127094457;37856.053598660255;38363.80818095891;30697;31278.90523831655;31285;31434.842825785723;31752.841235793672;24018.39954001164;24413.31797966997;24652.876735616923;24695.50608987774;24714.629280561167 06:14:48 INFO - PROCESS | 2001 | |2;jquery.html;358.24767987226824;376.70993335131965;386.82598314116643;401.6405317241067;403.3526190464304;15812.762808557867;16395.4261600844;21274.787252127473;21802.454938626543;21945;20367.287144949893;20971.056302466386;21026.89486552569;21634.675479867816;21690.89154554229;5964.910526342108;6173.104899789528;6216.440520353167;6217.253929528463;6217.285012223584;5970.522358211333;5974.864775692627;6168.074788781696;6193.225846769154;6222.875542489148;6085.178500902388;6152.969235153818;6180.381961803829;6182;6185.041318595602;5949.345571987078;6133.570650054498;6152.261728592597;6164.044573091178;6165.32181460039;5312.2297266896085;5402.324709411324;5403.83788486346;5406.729663516848;5409.756560954766;26338.68306584663;26637.334066648295;27109.72890271092;27128.59307110395;27598.44803103947;2190.9452263693374;2213.3249358945513;2528.5195812795696;2576.9226923192336;2959.081836327345;15227.010244334193;15265.465708700141;15320.616984575474;15510.612234694223;15762.527124186292;1715.365314833507;1769.1596491666485;1800.7659004329353;1854.0636978325858;1882.3317722208556;78235;80997.59501202575;107775.92224077816;115770;116275;18568.907155464138;22498.100075996776;22498.66252006221;22663.660045099336;22840.086396544284;36795;36957.630423695955;37678.42055004825;37857.43213851794;37930.62069379326;11328.830067548994;11744.119191060705;11764.647060588197;11827.763444731057;11892.227005244631;9497.287703422271;9561.61753529865;9600.711978640651;9667.468289244018;9694.51527423626;9994.450305233282;10288.897111028944;10390.948045259725;10429.530671119817;10455.424951627581;3821.6560509554274;3931.941020884689;3957.2876882161486;4014.297497937849;4055.965728739153;910.3400034974591;947.5167664491021;985.7239972807625;998.7053819123377;1011.2112552209288;19712.70430943537;20223.59552808965;20799.68800467994;20833.895830521054;21215.15139394438;969.1810420194925;970.9757256068655;983.6114734679761;984.9458279794537;1014.7716763728102;11112.611058612909;11532.308061516336;11565.306081635128;11906;11987.520499179935;649160;651001;651603.741981287;655803;675330;117973.41013294879;119869.80130198761;122046.38976805237;129831;132070;878.9516576588348;901.5312037740339;1043.4886905416442;1061.6814955513314;1069.337011053152;17272;17328.653426931643;17624.383146589807;17630.735538967183;17890.642187155925;51286;53184.73407632937;53656.73171634117;54814.72592637011;55659;77651;77962.6101869487;80032.19967800248;81165.59417202877;84627.73058404005;8226.62980165882;8271.875921861298;8348.958255208685;8399.832003360021;8642.481451112953;12384;12464.937675311929;12678.858902698801;12771.872281277068;12922;5727.341355744143;8396.496210227406;10275.537600807833;11235.831462528233;11419;11244.493997769956;11261.887381126084;11501.712457188638;11530.711732206762;11531.596394126165;10772.784544309226;11391.601293954673;11516.827247591125;11663.941680291884;11746.70633234176;7964.960175199087;8006.559639219899;8265.46274492156;8307.127751586238;8317.500949943023;10944.452777361259;11038.44807759625;11069.225154239448;11322.150838686966;11533.192676512563 06:14:48 INFO - PROCESS | 2001 | |3;mootools.html;1412.3714946848656;1500.2573726005628;1575.424969885992;1819.6633622779786;1978.0505357428433;7929;8638.26574741147;8824.382293239476;8834.204921557059;8841.95579022104;8530.488170709761;8786.560671966408;8805.16350946659;8811.471311721285;8816.206541411271;2446.840955337906;2462.839915405502;2469.6172093325563;2471.9629205561932;2475.9628605570842;2391.1869964212165;2467.2968204061845;2469.234537293436;2473.208573256559;2478.3432390416556;2432.20953190213;2456.275398757371;2467.370820440785;2467.8025757939413;2470.555300045991;2427.4416884116663;2449.8285120041605;2462.5444292805887;2464.4578192797644;2481.057198264648;2418.733939266679;2467.0501856785086;2475.1460746042585;2478.24413553866;2483.2301986384277;8504.489730616182;8804.64781408743;8860.113988601153;8863.778405539913;8864.335174861846;5372.382176049765;5583.832485025456;5587.944120558824;5591.189277554772;5591.860203494904;3518.753687241894;3580.6240344763946;3646.6717995380277;3655.689266412358;3658.579263384718;882.8101958078979;1030.876294844616;1049.727070961548;1065.4566171252638;1077.224398433127;11895.762084758342;11996.940015299955;11999.700007499796;12005.159638825286;12013.519459221709;4561.703489273253;4735.621150307967;4737.3841400618385;4762.357081793983;4768.403949506312;9316;9416.246700263962;9427.19868811145;9430.575624096931;9433.481158536346;5208.84373468789;5321.680699157985;5357.785688572491;5390.622656414092;5393.514583687487;4390.692651514427;4512.774361281923;4776.641751868554;4897.583705385011;4980.526849949249;3833.7316387852584;3864.8067596620617;3899.883003509899;3902.453656488094;3945.6448919597374;1054.3726482742757;1189.0725234317247;1199.8140288255333;1202.8857258560422;1214.8481439820023;710.2152121905324;807.5316316536395;844.572672184007;872.8952525696957;939.915407613318;5609.635373700697;5650.491455768918;5856.648601083949;5870.119482077723;5890.970545147246;929.8330595103102;939.9765005874771;951.46242373059;979.5053497983615;996.6013594562088;3309.8014119152926;3822;3827.9617203827606;3847.2305538892333;3911.413288006822;10547.208959328082;10814.026737593655;10947.56209751601;10953.83569246462;10973.83539246912;9953.552090155961;10544;10599.728032636132;10655.360678359168;10801.891981080089;8256.050554186346;8353.832923341499;8399.62201700925;8490.61792219364;8514.531700756394;5647.237622921018;5677.460641239076;5781.075027995501;5893.322267939242;5927.2590926134235;9315.673951411669;9448.858267125861;9565.473898935625;9583.233341332538;9589.712308630753;9480.620775168916;9834.164096051916;9971.102600765966;10242.6415075472;10262.281640285408;7537.472376933562;7537.8115547111765;7553.244675532403;7691.38468922496;7693.923060769321;8250.422470427253;8250.958745206235;8272.958635207026;8280.378971577034;8292.792680183044;7239.746608868664;7432.925670743223;7462.552246865205;7568.772936811904;7628.580428076509;7281.635918203962;7288;7324.377427918474;7415.962920185365;7448.217937116525;6896.551724137915;7041.823954401181;7067.57594544329;7081.079459670416;7087.645617719197;4710.811567537397;4765.976170119127;4781.784819683053;4895.265710143507;4952.306677065142;4858.368412106403;4902.289168070681;4908.63185261114;4962.33008543842;5084.3644544431945 06:14:48 INFO - PROCESS | 2001 | |4;prototype.html;321.97907136036156;326.0008075249361;330.58511567982185;332.41494968854823;336.725568661541;6650.667466626667;6739.8652026959435;6742.22464416591;6749.730010799574;6749.83125421864;6669.899951500719;6683.665816709169;6707.496937729666;6708.060871477997;6708.429783468411;4734.881627959311;4793.304970779235;4911.263310503436;4915.213565829468;4941.703497790126;4167.749935003894;4788.521147885219;4856.150173719585;4938.827141050064;4966.5778408835295;3908.706846986473;4827.155247831633;4871.342368780222;4892.192788189962;4902.950970490303;4679.92980105297;4768.070226305889;4872.683275587111;4872.829450969234;4881.438634557036;4160.83356665733;4169.853290345149;4174.290370636999;4177.289860723684;4186.1418409226035;6324.494040476797;6399.072134540512;6400.103985442041;6409.294977552466;6436.356364363573;5851.473367396955;5855.795047173371;5857.179994800731;5859.794907178229;5875.6474611523445;6782.015912998265;7071.398931090864;7082.185548661867;7096.822579435504;7097.751578694772;4588.334691469719;4605.0099228665995;4612.077584483117;4615.030843522864;4647;5492.670439773627;7460.36586890115;7574.810629734246;7618.162002179811;7620.961895190489;3937.42907278443;4652.13935421948;4657.790399432034;4675.971286317005;4684.531546845356;4735.95264047362;4740.478547359788;4741.336212930192;4744.1934871072;4750.311204875274;5685;5694.601377903507;5700.144978253295;5758.992176369119;5761.135829625506;5483.917741233885;7094.290570942968;7151.642417879189;7211.92788072123;7220.4584656151;1592.1402442681053;1638.3937942960943;1638.8197298297177;1639.295103105652;1640.6062544989118;848.6350869126212;969.069693094623;980.294188184506;1019.3527110285022;1045.4668119259234;6468.256150542654;6487.35126487357;6508.30783996155;6557.016447532908;6726;7466.552006879496;7467.439942004371;7493.737719179911;7494.100707914976;7496.550206987598;6688.4649228061635;6696.83257918556;6700.798976030727;6713.462922966151;6729.663516824139;3777.962220377816;3897.2595206910596;3950.9012274692786;3951.8024098794945;3951.980240098781;7825.843483130306;7852.057753069554;7862.056553213537;7863.977682901186;7866.410019248579;7666.8849967250535;7699.422543309274;7711.7300894469545;7726.18875018115;7730.613469326511;7828.021497312836;7834.099078605919;7835.942147809973;7836.059672839296;7857.764267071997;5964.910526342195;7103.644817758988;7431.777046688608;7447.627618619155;7462.813429664302;7266.781996540112;7282.344588987016;7310.378617817332;7371.520851144658;7383.741569045058;6328.968355158195;7869.055713314439;7878.72424465141;7904.367650587824;7904.920950790419;4608.677392582487;4672.159011377848;4675.672702910763;4678.976605116953;4683.695559788739;7143.964125201921;7410.481266311306;7437.144728356308;7451.3666338361845;7458.73894413693;7130.500864939404;7151.53515021522;7182.892256616259;7213.855722885618;7215.278472152742;7162.176349719641;7165.534240274365;7167.283271672791;7167.856642867009;7173.820654483679;7017.789466316019;7020.403265722266;7029.3673569379;7036.542624729376;7039;6890.104286442931;7169.247229040876;7188.784336469915;7199.604021778852;7220.133583969957;6689.498287628545;6875.209350924708;6879.380855723009;6998.300169983165;7021.68402421882 06:14:48 INFO - PROCESS | 2001 | |5;yui.html;596.4542443664047;660.9966950165249;664.5805394129042;712.0743034055727;724.3770357492556;15364;15371.692566148684;15381.077135371885;15392.769108463383;17173.91413042933;16271.755923661125;16350.182490875439;16368.345266189368;16382.935109217893;16390.26243819028;734.3390948146657;747.6859718918067;900.4507250577126;911.3165126155384;935.9251259899225;909.5315912305168;912.8402529557334;913.4793167894303;916.9958895009953;917.1287277086761;976.7216343342149;979.1530326267798;980.13258266434;981.6760469045198;982.5480279071636;768.8654485465049;952.8808898887639;968.5786682793008;969.1084202533651;972.0619602084023;618.7153909201772;725.0755287009106;725.5610355734757;725.905632267807;727.2000799120977;15227.238638068053;15396.538103856903;15403.614909627237;15414.998025128443;15433.3826646934;11414.771704565863;11620;12286.201396909262;12286.877131228663;12448.315342656151;9939.65211217604;10079.496025198783;10285.434301113435;10395.688129356131;10529.894701052968;2943.6026136471514;3472.5485686860548;3552.378333791576;3565.8217089145437;3715.3312403767313;78978;79552.60223698903;79612.80580791293;82744;84796;8812.8678069829;9014.368994170476;9082.987592953927;9220.07799220086;9322;19542.31601893927;19569.315073972342;19576.412707618794;19596.608067838562;19603.01984900749;7265.5277406969435;7315.231900650355;7448.441366897504;7450.739224127129;7540.622968851536;4157.417961485395;4182.581741825793;4205.369194620831;4220.725652832556;4392.956070439319;3608.9278214435562;3643.6720695137033;3662.1393972416463;3662.61542538035;3663.7618554794385;534.708772908087;567.3900556901348;644.291279592454;662.5825729790298;664.315754772585;540.284123536316;556.7466802604805;586.4663156527624;600.1058422949774;603.0863242188088;7599.696012159562;7691.888382879821;7875.645595948196;8026.558539280279;8153.5923203839575;513.2916575126302;535.7910414938177;590.0824218340522;592.733270028489;601.1073555769678;3643.690286325639;3750.099976005739;3815.294170578452;3830.616938306147;3901.464048368583;81597.59201204075;82184.76722849162;82257.35485290381;82425.58787206025;86395.56802216075;83875;84156;84848.45476476417;85583;87287;66646.33353666498;66753.3324666747;66889.66555167193;67235.32764672389;68212;7328.377087947584;7506.549607023596;7522.661480233293;7553.509021913558;7677.424193185645;32187.839060804545;50491.232806851585;50684;51083.23375149301;51241.48758512367;68826.65586672035;71836;71992;72821;73462.63268683622;9763.56063977137;9812;9996.550155242887;10180.440075795903;10574.84137737919;10688.144948403953;10878.456077196266;10946.288491248044;11031.39327336972;11292.491837867152;8297.092550050753;10323.741906452398;11599.188056835941;11778.705532361417;12104.636860894187;11200.719982000515;11490.655280341603;11493.425328733698;11807;11895.82156267674;10964.725881852699;11230.494627741935;11235.4382280884;11473.196876218584;11583.536658533565;9442.480663563296;9593.520323983912;9747.268954828558;9771.706848794547;9813.85279220798;9573.138417542455;9653.758656033375;9710.70867873965;9721.951390243003;9746.707598772047 06:14:48 INFO - PROCESS | 2001 | __end_tp_report 06:14:48 INFO - PROCESS | 2001 | __start_cc_report 06:14:48 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,1332 06:14:48 INFO - PROCESS | 2001 | __end_cc_report 06:14:48 INFO - PROCESS | 2001 | __startTimestamp1462799688756__endTimestamp 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | ------- Summary: start ------- 06:14:48 INFO - PROCESS | 2001 | Number of tests: 6 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:5825.05 Median:6094.79 stddev:624.41 (10.2%) stddev-sans-first:597.10 06:14:48 INFO - PROCESS | 2001 | Values: 3418.4 3483.5 3508.2 3531.5 3555.2 5820.6 5835.4 5840.4 5843.0 5905.6 5860.9 5864.5 5885.2 5887.1 5895.4 5201.6 5274.2 5296.3 5335.7 5413.7 5347.8 5363.5 5374.6 5375.1 5378.6 5314.3 5331.8 5353.7 5355.9 5365.7 5308.6 5333.6 5345.6 5346.3 5365.7 5132.6 5214.9 5249.9 5280.4 5289.4 5633.2 5659.5 5717.5 5728.8 5764.0 6282.2 6302.2 6308.1 6329.8 6336.4 6200.6 6217.8 6285.3 6291.4 6301.3 5941.0 5960.5 5961.1 5974.3 5980.0 6321.9 6332.3 6343.5 6347.4 6347.9 5273.8 6142.4 6210.0 6279.7 6299.0 6252.4 6260.9 6269.9 6281.3 6287.3 6304.7 6308.8 6320.4 6328.7 6333.1 6153.9 6219.5 6313.6 6327.8 6342.9 4958.3 4997.6 5010.7 5014.0 5029.1 4499.1 4512.3 4517.4 4543.6 4551.4 5652.4 5740.8 5774.3 5856.1 5858.6 5824.0 5847.9 6255.5 6273.3 6292.5 5772.8 5798.5 5804.5 5806.8 5816.1 5422.8 5447.1 5452.8 5499.8 5513.3 6326.8 6393.9 6406.8 6409.7 6438.1 6251.5 6274.0 6287.1 6292.1 6292.5 6270.6 6320.9 6368.1 6397.7 6407.1 6237.6 6244.0 6246.8 6256.3 6278.7 6260.1 6281.9 6305.6 6308.7 6343.7 6113.7 6180.6 6213.3 6246.2 6291.8 6181.4 6249.5 6257.5 6270.5 6283.0 5436.2 5933.9 6082.1 6094.8 6127.9 5871.4 6171.6 6263.6 6264.7 6282.4 6098.8 6113.2 6123.8 6135.0 6141.1 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:68005.92 Median:36360.36 stddev:148976.76 (409.7%) stddev-sans-first:149308.49 06:14:48 INFO - PROCESS | 2001 | Values: 510.6 522.8 526.6 582.9 584.1 30898.4 31476.8 38463.8 38879.4 38891.6 41675.2 42058.6 42136.2 42171.9 42173.0 8426.5 8489.4 9480.4 9785.3 9794.5 7426.5 8700.2 8701.9 10002.8 11555.8 11496.0 11534.4 11536.8 11568.9 11570.0 11477.4 11545.5 11550.5 11552.4 11596.4 8646.8 11500.4 11670.3 11695.0 11704.8 31400.5 38052.6 38423.8 38443.2 38454.0 3174.9 3176.5 3214.7 3304.7 3333.5 27053.9 27067.0 27266.2 27920.0 28425.1 2628.8 2650.8 2707.8 2707.9 2738.9 472853.0 473489.0 473568.0 473849.0 477598.0 36165.6 63294.4 63976.7 63988.0 63997.4 35574.0 35732.5 35767.8 35787.0 35844.9 15754.0 16037.0 16052.4 16078.8 16082.8 12253.0 13478.0 13576.7 13602.9 13613.5 7522.1 7599.7 7604.2 7607.6 8166.5 2875.0 3370.3 3376.4 3376.5 3406.1 899.6 945.0 960.0 1069.7 1071.2 24688.3 29753.1 29880.0 29963.4 30153.7 980.5 990.9 1069.3 1095.2 1097.9 15034.4 15820.1 15829.9 16218.9 16379.0 630596.0 634327.5 636771.8 637498.0 638962.0 61335.4 61638.1 61654.4 61797.7 61864.4 1456.2 1486.2 1504.4 1504.5 1508.1 29812.0 29868.4 30232.0 30936.5 31044.7 54504.5 54520.0 55222.0 55383.0 55480.4 540268.0 550157.0 551726.0 552141.0 554943.0 42573.1 43445.0 43746.8 43939.8 43987.6 42610.4 46661.8 47118.5 47129.5 47711.0 35014.6 37207.6 37383.8 37934.9 37996.0 36555.1 36682.8 36830.6 37428.0 37548.0 37370.6 37612.8 37745.8 37856.1 38363.8 30697.0 31278.9 31285.0 31434.8 31752.8 24018.4 24413.3 24652.9 24695.5 24714.6 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:37568.31 Median:26873.53 stddev:108484.26 (403.7%) stddev-sans-first:108752.61 06:14:48 INFO - PROCESS | 2001 | Values: 358.2 376.7 386.8 401.6 403.4 15812.8 16395.4 21274.8 21802.5 21945.0 20367.3 20971.1 21026.9 21634.7 21690.9 5964.9 6173.1 6216.4 6217.3 6217.3 5970.5 5974.9 6168.1 6193.2 6222.9 6085.2 6153.0 6180.4 6182.0 6185.0 5949.3 6133.6 6152.3 6164.0 6165.3 5312.2 5402.3 5403.8 5406.7 5409.8 26338.7 26637.3 27109.7 27128.6 27598.4 2190.9 2213.3 2528.5 2576.9 2959.1 15227.0 15265.5 15320.6 15510.6 15762.5 1715.4 1769.2 1800.8 1854.1 1882.3 78235.0 80997.6 107775.9 115770.0 116275.0 18568.9 22498.1 22498.7 22663.7 22840.1 36795.0 36957.6 37678.4 37857.4 37930.6 11328.8 11744.1 11764.6 11827.8 11892.2 9497.3 9561.6 9600.7 9667.5 9694.5 9994.5 10288.9 10390.9 10429.5 10455.4 3821.7 3931.9 3957.3 4014.3 4056.0 910.3 947.5 985.7 998.7 1011.2 19712.7 20223.6 20799.7 20833.9 21215.2 969.2 971.0 983.6 984.9 1014.8 11112.6 11532.3 11565.3 11906.0 11987.5 649160.0 651001.0 651603.7 655803.0 675330.0 117973.4 119869.8 122046.4 129831.0 132070.0 879.0 901.5 1043.5 1061.7 1069.3 17272.0 17328.7 17624.4 17630.7 17890.6 51286.0 53184.7 53656.7 54814.7 55659.0 77651.0 77962.6 80032.2 81165.6 84627.7 8226.6 8271.9 8349.0 8399.8 8642.5 12384.0 12464.9 12678.9 12771.9 12922.0 5727.3 8396.5 10275.5 11235.8 11419.0 11244.5 11261.9 11501.7 11530.7 11531.6 10772.8 11391.6 11516.8 11663.9 11746.7 7965.0 8006.6 8265.5 8307.1 8317.5 10944.5 11038.4 11069.2 11322.2 11533.2 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:5702.69 Median:5265.26 stddev:3174.42 (60.3%) stddev-sans-first:3166.95 06:14:48 INFO - PROCESS | 2001 | Values: 1412.4 1500.3 1575.4 1819.7 1978.1 7929.0 8638.3 8824.4 8834.2 8842.0 8530.5 8786.6 8805.2 8811.5 8816.2 2446.8 2462.8 2469.6 2472.0 2476.0 2391.2 2467.3 2469.2 2473.2 2478.3 2432.2 2456.3 2467.4 2467.8 2470.6 2427.4 2449.8 2462.5 2464.5 2481.1 2418.7 2467.1 2475.1 2478.2 2483.2 8504.5 8804.6 8860.1 8863.8 8864.3 5372.4 5583.8 5587.9 5591.2 5591.9 3518.8 3580.6 3646.7 3655.7 3658.6 882.8 1030.9 1049.7 1065.5 1077.2 11895.8 11996.9 11999.7 12005.2 12013.5 4561.7 4735.6 4737.4 4762.4 4768.4 9316.0 9416.2 9427.2 9430.6 9433.5 5208.8 5321.7 5357.8 5390.6 5393.5 4390.7 4512.8 4776.6 4897.6 4980.5 3833.7 3864.8 3899.9 3902.5 3945.6 1054.4 1189.1 1199.8 1202.9 1214.8 710.2 807.5 844.6 872.9 939.9 5609.6 5650.5 5856.6 5870.1 5891.0 929.8 940.0 951.5 979.5 996.6 3309.8 3822.0 3828.0 3847.2 3911.4 10547.2 10814.0 10947.6 10953.8 10973.8 9953.6 10544.0 10599.7 10655.4 10801.9 8256.1 8353.8 8399.6 8490.6 8514.5 5647.2 5677.5 5781.1 5893.3 5927.3 9315.7 9448.9 9565.5 9583.2 9589.7 9480.6 9834.2 9971.1 10242.6 10262.3 7537.5 7537.8 7553.2 7691.4 7693.9 8250.4 8251.0 8273.0 8280.4 8292.8 7239.7 7432.9 7462.6 7568.8 7628.6 7281.6 7288.0 7324.4 7416.0 7448.2 6896.6 7041.8 7067.6 7081.1 7087.6 4710.8 4766.0 4781.8 4895.3 4952.3 4858.4 4902.3 4908.6 4962.3 5084.4 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:5832.25 Median:6698.82 stddev:1900.49 (28.4%) stddev-sans-first:1860.28 06:14:48 INFO - PROCESS | 2001 | Values: 322.0 326.0 330.6 332.4 336.7 6650.7 6739.9 6742.2 6749.7 6749.8 6669.9 6683.7 6707.5 6708.1 6708.4 4734.9 4793.3 4911.3 4915.2 4941.7 4167.7 4788.5 4856.2 4938.8 4966.6 3908.7 4827.2 4871.3 4892.2 4903.0 4679.9 4768.1 4872.7 4872.8 4881.4 4160.8 4169.9 4174.3 4177.3 4186.1 6324.5 6399.1 6400.1 6409.3 6436.4 5851.5 5855.8 5857.2 5859.8 5875.6 6782.0 7071.4 7082.2 7096.8 7097.8 4588.3 4605.0 4612.1 4615.0 4647.0 5492.7 7460.4 7574.8 7618.2 7621.0 3937.4 4652.1 4657.8 4676.0 4684.5 4736.0 4740.5 4741.3 4744.2 4750.3 5685.0 5694.6 5700.1 5759.0 5761.1 5483.9 7094.3 7151.6 7211.9 7220.5 1592.1 1638.4 1638.8 1639.3 1640.6 848.6 969.1 980.3 1019.4 1045.5 6468.3 6487.4 6508.3 6557.0 6726.0 7466.6 7467.4 7493.7 7494.1 7496.6 6688.5 6696.8 6700.8 6713.5 6729.7 3778.0 3897.3 3950.9 3951.8 3952.0 7825.8 7852.1 7862.1 7864.0 7866.4 7666.9 7699.4 7711.7 7726.2 7730.6 7828.0 7834.1 7835.9 7836.1 7857.8 5964.9 7103.6 7431.8 7447.6 7462.8 7266.8 7282.3 7310.4 7371.5 7383.7 6329.0 7869.1 7878.7 7904.4 7904.9 4608.7 4672.2 4675.7 4679.0 4683.7 7144.0 7410.5 7437.1 7451.4 7458.7 7130.5 7151.5 7182.9 7213.9 7215.3 7162.2 7165.5 7167.3 7167.9 7173.8 7017.8 7020.4 7029.4 7036.5 7039.0 6890.1 7169.2 7188.8 7199.6 7220.1 6689.5 6875.2 6879.4 6998.3 7021.7 06:14:48 INFO - PROCESS | 2001 | 06:14:48 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:18125.42 Median:661.79 stddev:25531.79 (3858.0%) stddev-sans-first:25569.49 06:14:48 INFO - PROCESS | 2001 | Values: 596.5 661.0 664.6 712.1 724.4 15364.0 15371.7 15381.1 15392.8 17173.9 16271.8 16350.2 16368.3 16382.9 16390.3 734.3 747.7 900.5 911.3 935.9 909.5 912.8 913.5 917.0 917.1 976.7 979.2 980.1 981.7 982.5 768.9 952.9 968.6 969.1 972.1 618.7 725.1 725.6 725.9 727.2 15227.2 15396.5 15403.6 15415.0 15433.4 11414.8 11620.0 12286.2 12286.9 12448.3 9939.7 10079.5 10285.4 10395.7 10529.9 2943.6 3472.5 3552.4 3565.8 3715.3 78978.0 79552.6 79612.8 82744.0 84796.0 8812.9 9014.4 9083.0 9220.1 9322.0 19542.3 19569.3 19576.4 19596.6 19603.0 7265.5 7315.2 7448.4 7450.7 7540.6 4157.4 4182.6 4205.4 4220.7 4393.0 3608.9 3643.7 3662.1 3662.6 3663.8 534.7 567.4 644.3 662.6 664.3 540.3 556.7 586.5 600.1 603.1 7599.7 7691.9 7875.6 8026.6 8153.6 513.3 535.8 590.1 592.7 601.1 3643.7 3750.1 3815.3 3830.6 3901.5 81597.6 82184.8 82257.4 82425.6 86395.6 83875.0 84156.0 84848.5 85583.0 87287.0 66646.3 66753.3 66889.7 67235.3 68212.0 7328.4 7506.5 7522.7 7553.5 7677.4 32187.8 50491.2 50684.0 51083.2 51241.5 68826.7 71836.0 71992.0 72821.0 73462.6 9763.6 9812.0 9996.6 10180.4 10574.8 10688.1 10878.5 10946.3 11031.4 11292.5 8297.1 10323.7 11599.2 11778.7 12104.6 11200.7 11490.7 11493.4 11807.0 11895.8 10964.7 11230.5 11235.4 11473.2 11583.5 9442.5 9593.5 9747.3 9771.7 9813.9 9573.1 9653.8 9710.7 9722.0 9746.7 06:14:48 INFO - PROCESS | 2001 | -------- Summary: end -------- 06:14:48 INFO - PROCESS | 2001 | 06:14:49 INFO - TEST-INFO | 2001: exit 0 06:14:49 INFO - TEST-OK | dromaeo_css | took 1115187ms 06:14:49 INFO - TEST-START | kraken 06:14:49 INFO - operating with platform_type : mac_ 06:14:49 INFO - Initialising browser for kraken test... 06:14:49 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpz3G_6B/profile http://localhost:49581/getInfo.html) 06:14:51 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 06:14:51 INFO - PROCESS | 2004 | colorDepth:24 06:14:51 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 06:14:51 INFO - PROCESS | 2004 | __metrics 06:14:51 INFO - PROCESS | 2004 | 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:14:51 ERROR - PROCESS | 2004 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:14:52 INFO - TEST-INFO | 2004: exit 0 06:14:52 INFO - Browser initialized. 06:14:52 INFO - Running cycle 1/1 for kraken test... 06:14:52 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpz3G_6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:04 INFO - PROCESS | 2006 | RSS: Main: 211161088 06:15:04 INFO - PROCESS | 2006 | 06:15:07 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49581/tests/kraken/driver.html?testName=audio-beat-detection) 06:15:08 INFO - PROCESS | 2006 | RSS: Main: 271298560 06:15:08 INFO - PROCESS | 2006 | 06:15:10 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49581/tests/kraken/driver.html?testName=audio-dft) 06:15:11 INFO - PROCESS | 2006 | RSS: Main: 285626368 06:15:11 INFO - PROCESS | 2006 | 06:15:14 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49581/tests/kraken/driver.html?testName=audio-fft) 06:15:15 INFO - PROCESS | 2006 | RSS: Main: 372355072 06:15:15 INFO - PROCESS | 2006 | 06:15:17 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49581/tests/kraken/driver.html?testName=audio-oscillator) 06:15:17 INFO - PROCESS | 2006 | RSS: Main: 277975040 06:15:17 INFO - PROCESS | 2006 | 06:15:20 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:15:20 INFO - PROCESS | 2006 | RSS: Main: 279744512 06:15:20 INFO - PROCESS | 2006 | 06:15:23 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49581/tests/kraken/driver.html?testName=imaging-darkroom) 06:15:24 INFO - PROCESS | 2006 | RSS: Main: 317603840 06:15:24 INFO - PROCESS | 2006 | 06:15:26 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49581/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:27 INFO - PROCESS | 2006 | RSS: Main: 316923904 06:15:27 INFO - PROCESS | 2006 | 06:15:30 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49581/tests/kraken/driver.html?testName=json-parse-financial) 06:15:30 INFO - PROCESS | 2006 | RSS: Main: 316968960 06:15:30 INFO - PROCESS | 2006 | 06:15:32 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:33 INFO - PROCESS | 2006 | RSS: Main: 308789248 06:15:33 INFO - PROCESS | 2006 | 06:15:34 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:35 INFO - PROCESS | 2006 | RSS: Main: 316616704 06:15:35 INFO - PROCESS | 2006 | 06:15:37 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:38 INFO - PROCESS | 2006 | RSS: Main: 318599168 06:15:38 INFO - PROCESS | 2006 | 06:15:41 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:41 INFO - PROCESS | 2006 | RSS: Main: 323424256 06:15:41 INFO - PROCESS | 2006 | 06:15:44 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:45 INFO - PROCESS | 2006 | RSS: Main: 321363968 06:15:45 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49581/tests/kraken/driver.html?testName=ai-astar) 06:15:47 INFO - PROCESS | 2006 | RSS: Main: 385527808 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | __start_tp_report 06:15:47 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 06:15:47 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 06:15:47 INFO - PROCESS | 2006 | |i|pagename|runs| 06:15:47 INFO - PROCESS | 2006 | |0;ai-astar;113;114;119;113;112;112;114;113;115;136 06:15:47 INFO - PROCESS | 2006 | |1;audio-beat-detection;153;122;160;156;119;141;117;156;157;116 06:15:47 INFO - PROCESS | 2006 | |2;audio-dft;186;184;186;186;184;187;183;186;186;185 06:15:47 INFO - PROCESS | 2006 | |3;audio-fft;70;103;63;171;45;66;73;74;156;46 06:15:47 INFO - PROCESS | 2006 | |4;audio-oscillator;96;95;143;77;84;93;126;79;75;137 06:15:47 INFO - PROCESS | 2006 | |5;imaging-gaussian-blur;87;85;87;85;87;88;89;84;87;87 06:15:47 INFO - PROCESS | 2006 | |6;imaging-darkroom;92;92;92;93;92;92;93;93;93;92 06:15:47 INFO - PROCESS | 2006 | |7;imaging-desaturate;84;84;85;84;84;84;84;85;85;89 06:15:47 INFO - PROCESS | 2006 | |8;json-parse-financial;61;63;63;65;62;63;62;83;57;58 06:15:47 INFO - PROCESS | 2006 | |9;json-stringify-tinderbox;66;70;72;76;74;70;69;70;71;69 06:15:47 INFO - PROCESS | 2006 | |10;stanford-crypto-aes;80;80;79;80;81;80;80;79;81;85 06:15:47 INFO - PROCESS | 2006 | |11;stanford-crypto-ccm;132;143;146;138;125;130;131;132;165;159 06:15:47 INFO - PROCESS | 2006 | |12;stanford-crypto-pbkdf2;175;167;177;212;221;167;170;164;174;163 06:15:47 INFO - PROCESS | 2006 | |13;stanford-crypto-sha256-iterative;69;69;68;56;81;89;97;99;66;67 06:15:47 INFO - PROCESS | 2006 | __end_tp_report 06:15:47 INFO - PROCESS | 2006 | __start_cc_report 06:15:47 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,2028 06:15:47 INFO - PROCESS | 2006 | __end_cc_report 06:15:47 INFO - PROCESS | 2006 | __startTimestamp1462799747562__endTimestamp 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | ------- Summary: start ------- 06:15:47 INFO - PROCESS | 2006 | Number of tests: 14 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#0] ai-astar Cycles:10 Average:116.10 Median:114.00 stddev:7.28 (6.4%) stddev-sans-first:7.63 06:15:47 INFO - PROCESS | 2006 | Values: 113.0 114.0 119.0 113.0 112.0 112.0 114.0 113.0 115.0 136.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:154.50 stddev:18.97 (12.3%) stddev-sans-first:19.50 06:15:47 INFO - PROCESS | 2006 | Values: 153.0 122.0 160.0 156.0 119.0 141.0 117.0 156.0 157.0 116.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#2] audio-dft Cycles:10 Average:185.30 Median:186.00 stddev:1.25 (0.7%) stddev-sans-first:1.30 06:15:47 INFO - PROCESS | 2006 | Values: 186.0 184.0 186.0 186.0 184.0 187.0 183.0 186.0 186.0 185.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#3] audio-fft Cycles:10 Average:86.70 Median:64.50 stddev:43.70 (67.8%) stddev-sans-first:45.93 06:15:47 INFO - PROCESS | 2006 | Values: 70.0 103.0 63.0 171.0 45.0 66.0 73.0 74.0 156.0 46.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:81.50 stddev:25.46 (31.2%) stddev-sans-first:26.95 06:15:47 INFO - PROCESS | 2006 | Values: 96.0 95.0 143.0 77.0 84.0 93.0 126.0 79.0 75.0 137.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 06:15:47 INFO - PROCESS | 2006 | Values: 87.0 85.0 87.0 85.0 87.0 88.0 89.0 84.0 87.0 87.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:15:47 INFO - PROCESS | 2006 | Values: 92.0 92.0 92.0 93.0 92.0 92.0 93.0 93.0 93.0 92.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:84.50 stddev:1.55 (1.8%) stddev-sans-first:1.62 06:15:47 INFO - PROCESS | 2006 | Values: 84.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 85.0 89.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:7.20 (11.4%) stddev-sans-first:7.57 06:15:47 INFO - PROCESS | 2006 | Values: 61.0 63.0 63.0 65.0 62.0 63.0 62.0 83.0 57.0 58.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:2.79 (4.0%) stddev-sans-first:2.39 06:15:47 INFO - PROCESS | 2006 | Values: 66.0 70.0 72.0 76.0 74.0 70.0 69.0 70.0 71.0 69.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:1.72 (2.1%) stddev-sans-first:1.81 06:15:47 INFO - PROCESS | 2006 | Values: 80.0 80.0 79.0 80.0 81.0 80.0 80.0 79.0 81.0 85.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:140.50 stddev:13.20 (9.4%) stddev-sans-first:13.67 06:15:47 INFO - PROCESS | 2006 | Values: 132.0 143.0 146.0 138.0 125.0 130.0 131.0 132.0 165.0 159.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:174.50 stddev:20.41 (11.7%) stddev-sans-first:21.59 06:15:47 INFO - PROCESS | 2006 | Values: 175.0 167.0 177.0 212.0 221.0 167.0 170.0 164.0 174.0 163.0 06:15:47 INFO - PROCESS | 2006 | 06:15:47 INFO - PROCESS | 2006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:75.00 stddev:14.56 (19.4%) stddev-sans-first:15.21 06:15:47 INFO - PROCESS | 2006 | Values: 69.0 69.0 68.0 56.0 81.0 89.0 97.0 99.0 66.0 67.0 06:15:47 INFO - PROCESS | 2006 | -------- Summary: end -------- 06:15:47 INFO - PROCESS | 2006 | 06:15:48 INFO - TEST-INFO | 2006: exit 0 06:15:48 INFO - TEST-OK | kraken | took 58990ms 06:15:48 INFO - SUITE-END | took 1174s 06:15:48 INFO - Completed test suite (00:19:34) 06:15:48 INFO - javascript benchmark 06:15:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.418868792305, 3483.494893240482, 3508.1580420699024, 3531.4702794580826, 3555.2000799820025, 5820.621659592129, 5835.358110607835, 5840.415958404168, 5843.035899076658, 5905.557083218754, 5860.912086318709, 5864.472197502224, 5885.234919460475, 5887.116932460122, 5895.4399332063385, 5201.5838732901275, 5274.156135018388, 5296.285001524783, 5335.653182543142, 5413.702246376448, 5347.812826551071, 5363.490468405515, 5374.6237763356585, 5375.0593646111965, 5378.569714422837, 5314.335708036496, 5331.760070796804, 5353.652012619187, 5355.892882142355, 5365.678059316434, 5308.601854860901, 5333.573314134898, 5345.5990800689715, 5346.304980352568, 5365.678059316453, 5132.563732082777, 5214.8696282592855, 5249.947500524984, 5280.3663560372615, 5289.365276166846, 5633.211350410946, 5659.490645841894, 5717.456841600041, 5728.770849166029, 5764.0, 6282.151909492206, 6302.243730752339, 6308.148399966038, 6329.8417539561415, 6336.429721325103, 6200.565960382775, 6217.813465596039, 6285.277193122758, 6291.402316779899, 6301.306856245809, 5940.970295148497, 5960.493358064569, 5961.135635332853, 5974.253218347707, 5979.970100149471, 6321.873562528724, 6332.303446620868, 6343.460805831556, 6347.365263473708, 6347.904781428282, 5273.841784746463, 6142.437386315926, 6210.0, 6279.686015699197, 6298.968505157445, 6252.374762523802, 6260.906086408708, 6269.937300627026, 6281.3404592518045, 6287.339829317947, 6304.65324407162, 6308.810735677937, 6320.367963203643, 6328.746850125944, 6333.113364129025, 6153.923063463965, 6219.47134493564, 6313.55805093639, 6327.841803954846, 6342.873142537216, 4958.330625365529, 4997.575206107449, 5010.724410157403, 5014.047331007097, 5029.0947629427055, 4499.145162419195, 4512.300593408027, 4517.435320584927, 4543.613792827647, 4551.431071116111, 5652.378238393773, 5740.770369185186, 5774.2782152230975, 5856.121581762684, 5858.619189752652, 5824.0, 5847.918135145012, 6255.499560035186, 6273.278572964076, 6292.528060395397, 5772.7690892363835, 5798.5071268941765, 5804.535637149018, 5806.79676211339, 5816.127580862904, 5422.783088676488, 5447.073997420448, 5452.781888724486, 5499.835004949858, 5513.338399392019, 6326.841828954313, 6393.904091438632, 6406.775762848278, 6409.743610255631, 6438.066480360415, 6251.499880009679, 6274.0, 6287.088372186099, 6292.11910332563, 6292.465140463112, 6270.623762574078, 6320.873582528232, 6368.140301059298, 6397.744090236524, 6407.070974708734, 6237.563370564017, 6244.0321750128805, 6246.812595622138, 6256.343083976117, 6278.686065696788, 6260.123582698517, 6281.874362512815, 6305.558610897377, 6308.653024083719, 6343.682815859281, 6113.694315284307, 6180.567360284737, 6213.254409470893, 6246.156768836149, 6291.811245662638, 6181.412765787423, 6249.531285153723, 6257.499400047895, 6270.529710271657, 6283.02613094971, 5436.238926550207, 5933.881322373442, 6082.057281121433, 6094.786682466092, 6127.877442451215, 5871.442212989759, 6171.5988460751705, 6263.592866463665, 6264.718087686157, 6282.403171698681, 6098.75604975796, 6113.174721412553, 6123.785667501616, 6135.049067394561, 6141.07883817431], "value": 5786.584651107378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.6017306500929, 522.754305476426, 526.6129394894751, 582.8688545077357, 584.0596639410551, 30898.382032359368, 31476.842615786918, 38463.846084617435, 38879.41680874789, 38891.611083889155, 41675.16649667012, 42058.57941420585, 42136.15727685452, 42171.94570135748, 42173.0, 8426.452280601741, 8489.363297752663, 9480.431174129557, 9785.315027948047, 9794.510274486247, 7426.480146389755, 8700.216980471756, 8701.912980870173, 10002.849957250646, 11555.768884622303, 11496.0, 11534.365609891494, 11536.826947595793, 11568.884311156908, 11570.0, 11477.426128693574, 11545.53817847285, 11550.53797848085, 11552.422378881107, 11596.362200078993, 8646.783830404227, 11500.367479788609, 11670.299782013106, 11695.005924496429, 11704.824427633592, 31400.528992065138, 38052.619473805185, 38423.807880960696, 38443.23113537714, 38454.03864903372, 3174.873005079794, 3176.5076413156, 3214.6624604416434, 3304.7190988765983, 3333.4666453367345, 27053.86473067622, 27067.0, 27266.182014539594, 27920.0, 28425.147245582666, 2628.8028397870235, 2650.801189910745, 2707.7969152313653, 2707.9323016924536, 2738.931526711828, 472853.0, 473488.99999999657, 473568.0, 473849.0, 477598.0, 36165.63834361623, 63294.36705632977, 63976.68011659912, 63988.0, 63997.36002640007, 35574.0, 35732.464013039826, 35767.82116089455, 35787.0, 35844.92465226047, 15754.0, 16037.0, 16052.438164664414, 16078.75881861773, 16082.758758618631, 12253.0, 13478.0, 13576.728465430833, 13602.93198534001, 13613.523526676718, 7522.134954480195, 7599.734009309647, 7604.163542010375, 7607.619619019027, 8166.469179503313, 2875.0, 3370.3259348130473, 3376.442886923679, 3376.493525971124, 3406.0633325835097, 899.635647562725, 945.0, 959.9808003839884, 1069.7379142110233, 1071.2447724354467, 24688.259352219462, 29753.10740677783, 29880.0, 29963.368137756, 30153.698463015528, 980.4656462228103, 990.9009099090033, 1069.3049517813329, 1095.2388090277182, 1097.9341239525654, 15034.398624055135, 15820.129892855774, 15829.920850395674, 16218.945768525007, 16379.0172589645, 630596.0, 634327.455264505, 636771.8161409163, 637498.0, 638962.0, 61335.38664613386, 61638.0754288686, 61654.383456165764, 61797.69101154465, 61864.38135618586, 1456.2427537680558, 1486.2271618757968, 1504.428317239464, 1504.5411149599477, 1508.1328236264192, 29812.0, 29868.402631947672, 30232.0, 30936.53595196119, 31044.68955310418, 54504.45495544994, 54520.0, 55222.0, 55383.0, 55480.44519554753, 540268.0, 550157.0, 551726.0, 552141.0, 554943.0, 42573.148537028464, 43445.0, 43746.781266093465, 43939.78030109829, 43987.56012439963, 42610.360844586736, 46661.766691167686, 47118.52881471279, 47129.52870471252, 47711.0, 35014.64985350114, 37207.6279237215, 37383.81308093442, 37934.86195414142, 37996.0, 36555.08612284714, 36682.816585917964, 36830.63169368379, 37428.0, 37548.0, 37370.626293737805, 37612.81193594124, 37745.81127094457, 37856.053598660255, 38363.80818095891, 30697.0, 31278.90523831655, 31285.0, 31434.842825785723, 31752.841235793672, 24018.39954001164, 24413.31797966997, 24652.876735616923, 24695.50608987774, 24714.629280561167], "value": 18953.860402145845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.24767987226824, 376.70993335131965, 386.82598314116643, 401.6405317241067, 403.3526190464304, 15812.762808557867, 16395.4261600844, 21274.787252127473, 21802.454938626543, 21945.0, 20367.287144949893, 20971.056302466386, 21026.89486552569, 21634.675479867816, 21690.89154554229, 5964.910526342108, 6173.104899789528, 6216.440520353167, 6217.253929528463, 6217.285012223584, 5970.522358211333, 5974.864775692627, 6168.074788781696, 6193.225846769154, 6222.875542489148, 6085.178500902388, 6152.969235153818, 6180.381961803829, 6182.0, 6185.041318595602, 5949.345571987078, 6133.570650054498, 6152.261728592597, 6164.044573091178, 6165.32181460039, 5312.2297266896085, 5402.324709411324, 5403.83788486346, 5406.729663516848, 5409.756560954766, 26338.68306584663, 26637.334066648295, 27109.72890271092, 27128.59307110395, 27598.44803103947, 2190.9452263693374, 2213.3249358945513, 2528.5195812795696, 2576.9226923192336, 2959.081836327345, 15227.010244334193, 15265.465708700141, 15320.616984575474, 15510.612234694223, 15762.527124186292, 1715.365314833507, 1769.1596491666485, 1800.7659004329353, 1854.0636978325858, 1882.3317722208556, 78235.0, 80997.59501202575, 107775.92224077816, 115770.0, 116275.0, 18568.907155464138, 22498.100075996776, 22498.66252006221, 22663.660045099336, 22840.086396544284, 36795.0, 36957.630423695955, 37678.42055004825, 37857.43213851794, 37930.62069379326, 11328.830067548994, 11744.119191060705, 11764.647060588197, 11827.763444731057, 11892.227005244631, 9497.287703422271, 9561.61753529865, 9600.711978640651, 9667.468289244018, 9694.51527423626, 9994.450305233282, 10288.897111028944, 10390.948045259725, 10429.530671119817, 10455.424951627581, 3821.6560509554274, 3931.941020884689, 3957.2876882161486, 4014.297497937849, 4055.965728739153, 910.3400034974591, 947.5167664491021, 985.7239972807625, 998.7053819123377, 1011.2112552209288, 19712.70430943537, 20223.59552808965, 20799.68800467994, 20833.895830521054, 21215.15139394438, 969.1810420194925, 970.9757256068655, 983.6114734679761, 984.9458279794537, 1014.7716763728102, 11112.611058612909, 11532.308061516336, 11565.306081635128, 11906.0, 11987.520499179935, 649160.0, 651001.0, 651603.741981287, 655803.0, 675330.0, 117973.41013294879, 119869.80130198761, 122046.38976805237, 129831.0, 132070.0, 878.9516576588348, 901.5312037740339, 1043.4886905416442, 1061.6814955513314, 1069.337011053152, 17272.0, 17328.653426931643, 17624.383146589807, 17630.735538967183, 17890.642187155925, 51286.0, 53184.73407632937, 53656.73171634117, 54814.72592637011, 55659.0, 77651.0, 77962.6101869487, 80032.19967800248, 81165.59417202877, 84627.73058404005, 8226.62980165882, 8271.875921861298, 8348.958255208685, 8399.832003360021, 8642.481451112953, 12384.0, 12464.937675311929, 12678.858902698801, 12771.872281277068, 12922.0, 5727.341355744143, 8396.496210227406, 10275.537600807833, 11235.831462528233, 11419.0, 11244.493997769956, 11261.887381126084, 11501.712457188638, 11530.711732206762, 11531.596394126165, 10772.784544309226, 11391.601293954673, 11516.827247591125, 11663.941680291884, 11746.70633234176, 7964.960175199087, 8006.559639219899, 8265.46274492156, 8307.127751586238, 8317.500949943023, 10944.452777361259, 11038.44807759625, 11069.225154239448, 11322.150838686966, 11533.192676512563], "value": 10762.99083813612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.3714946848656, 1500.2573726005628, 1575.424969885992, 1819.6633622779786, 1978.0505357428433, 7929.0, 8638.26574741147, 8824.382293239476, 8834.204921557059, 8841.95579022104, 8530.488170709761, 8786.560671966408, 8805.16350946659, 8811.471311721285, 8816.206541411271, 2446.840955337906, 2462.839915405502, 2469.6172093325563, 2471.9629205561932, 2475.9628605570842, 2391.1869964212165, 2467.2968204061845, 2469.234537293436, 2473.208573256559, 2478.3432390416556, 2432.20953190213, 2456.275398757371, 2467.370820440785, 2467.8025757939413, 2470.555300045991, 2427.4416884116663, 2449.8285120041605, 2462.5444292805887, 2464.4578192797644, 2481.057198264648, 2418.733939266679, 2467.0501856785086, 2475.1460746042585, 2478.24413553866, 2483.2301986384277, 8504.489730616182, 8804.64781408743, 8860.113988601153, 8863.778405539913, 8864.335174861846, 5372.382176049765, 5583.832485025456, 5587.944120558824, 5591.189277554772, 5591.860203494904, 3518.753687241894, 3580.6240344763946, 3646.6717995380277, 3655.689266412358, 3658.579263384718, 882.8101958078979, 1030.876294844616, 1049.727070961548, 1065.4566171252638, 1077.224398433127, 11895.762084758342, 11996.940015299955, 11999.700007499796, 12005.159638825286, 12013.519459221709, 4561.703489273253, 4735.621150307967, 4737.3841400618385, 4762.357081793983, 4768.403949506312, 9316.0, 9416.246700263962, 9427.19868811145, 9430.575624096931, 9433.481158536346, 5208.84373468789, 5321.680699157985, 5357.785688572491, 5390.622656414092, 5393.514583687487, 4390.692651514427, 4512.774361281923, 4776.641751868554, 4897.583705385011, 4980.526849949249, 3833.7316387852584, 3864.8067596620617, 3899.883003509899, 3902.453656488094, 3945.6448919597374, 1054.3726482742757, 1189.0725234317247, 1199.8140288255333, 1202.8857258560422, 1214.8481439820023, 710.2152121905324, 807.5316316536395, 844.572672184007, 872.8952525696957, 939.915407613318, 5609.635373700697, 5650.491455768918, 5856.648601083949, 5870.119482077723, 5890.970545147246, 929.8330595103102, 939.9765005874771, 951.46242373059, 979.5053497983615, 996.6013594562088, 3309.8014119152926, 3822.0, 3827.9617203827606, 3847.2305538892333, 3911.413288006822, 10547.208959328082, 10814.026737593655, 10947.56209751601, 10953.83569246462, 10973.83539246912, 9953.552090155961, 10544.0, 10599.728032636132, 10655.360678359168, 10801.891981080089, 8256.050554186346, 8353.832923341499, 8399.62201700925, 8490.61792219364, 8514.531700756394, 5647.237622921018, 5677.460641239076, 5781.075027995501, 5893.322267939242, 5927.2590926134235, 9315.673951411669, 9448.858267125861, 9565.473898935625, 9583.233341332538, 9589.712308630753, 9480.620775168916, 9834.164096051916, 9971.102600765966, 10242.6415075472, 10262.281640285408, 7537.472376933562, 7537.8115547111765, 7553.244675532403, 7691.38468922496, 7693.923060769321, 8250.422470427253, 8250.958745206235, 8272.958635207026, 8280.378971577034, 8292.792680183044, 7239.746608868664, 7432.925670743223, 7462.552246865205, 7568.772936811904, 7628.580428076509, 7281.635918203962, 7288.0, 7324.377427918474, 7415.962920185365, 7448.217937116525, 6896.551724137915, 7041.823954401181, 7067.57594544329, 7081.079459670416, 7087.645617719197, 4710.811567537397, 4765.976170119127, 4781.784819683053, 4895.265710143507, 4952.306677065142, 4858.368412106403, 4902.289168070681, 4908.63185261114, 4962.33008543842, 5084.3644544431945], "value": 4586.1237776206135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.97907136036156, 326.0008075249361, 330.58511567982185, 332.41494968854823, 336.725568661541, 6650.667466626667, 6739.8652026959435, 6742.22464416591, 6749.730010799574, 6749.83125421864, 6669.899951500719, 6683.665816709169, 6707.496937729666, 6708.060871477997, 6708.429783468411, 4734.881627959311, 4793.304970779235, 4911.263310503436, 4915.213565829468, 4941.703497790126, 4167.749935003894, 4788.521147885219, 4856.150173719585, 4938.827141050064, 4966.5778408835295, 3908.706846986473, 4827.155247831633, 4871.342368780222, 4892.192788189962, 4902.950970490303, 4679.92980105297, 4768.070226305889, 4872.683275587111, 4872.829450969234, 4881.438634557036, 4160.83356665733, 4169.853290345149, 4174.290370636999, 4177.289860723684, 4186.1418409226035, 6324.494040476797, 6399.072134540512, 6400.103985442041, 6409.294977552466, 6436.356364363573, 5851.473367396955, 5855.795047173371, 5857.179994800731, 5859.794907178229, 5875.6474611523445, 6782.015912998265, 7071.398931090864, 7082.185548661867, 7096.822579435504, 7097.751578694772, 4588.334691469719, 4605.0099228665995, 4612.077584483117, 4615.030843522864, 4647.0, 5492.670439773627, 7460.36586890115, 7574.810629734246, 7618.162002179811, 7620.961895190489, 3937.42907278443, 4652.13935421948, 4657.790399432034, 4675.971286317005, 4684.531546845356, 4735.95264047362, 4740.478547359788, 4741.336212930192, 4744.1934871072, 4750.311204875274, 5685.0, 5694.601377903507, 5700.144978253295, 5758.992176369119, 5761.135829625506, 5483.917741233885, 7094.290570942968, 7151.642417879189, 7211.92788072123, 7220.4584656151, 1592.1402442681053, 1638.3937942960943, 1638.8197298297177, 1639.295103105652, 1640.6062544989118, 848.6350869126212, 969.069693094623, 980.294188184506, 1019.3527110285022, 1045.4668119259234, 6468.256150542654, 6487.35126487357, 6508.30783996155, 6557.016447532908, 6726.0, 7466.552006879496, 7467.439942004371, 7493.737719179911, 7494.100707914976, 7496.550206987598, 6688.4649228061635, 6696.83257918556, 6700.798976030727, 6713.462922966151, 6729.663516824139, 3777.962220377816, 3897.2595206910596, 3950.9012274692786, 3951.8024098794945, 3951.980240098781, 7825.843483130306, 7852.057753069554, 7862.056553213537, 7863.977682901186, 7866.410019248579, 7666.8849967250535, 7699.422543309274, 7711.7300894469545, 7726.18875018115, 7730.613469326511, 7828.021497312836, 7834.099078605919, 7835.942147809973, 7836.059672839296, 7857.764267071997, 5964.910526342195, 7103.644817758988, 7431.777046688608, 7447.627618619155, 7462.813429664302, 7266.781996540112, 7282.344588987016, 7310.378617817332, 7371.520851144658, 7383.741569045058, 6328.968355158195, 7869.055713314439, 7878.72424465141, 7904.367650587824, 7904.920950790419, 4608.677392582487, 4672.159011377848, 4675.672702910763, 4678.976605116953, 4683.695559788739, 7143.964125201921, 7410.481266311306, 7437.144728356308, 7451.3666338361845, 7458.73894413693, 7130.500864939404, 7151.53515021522, 7182.892256616259, 7213.855722885618, 7215.278472152742, 7162.176349719641, 7165.534240274365, 7167.283271672791, 7167.856642867009, 7173.820654483679, 7017.789466316019, 7020.403265722266, 7029.3673569379, 7036.542624729376, 7039.0, 6890.104286442931, 7169.247229040876, 7188.784336469915, 7199.604021778852, 7220.133583969957, 6689.498287628545, 6875.209350924708, 6879.380855723009, 6998.300169983165, 7021.68402421882], "value": 5187.028574234549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.4542443664047, 660.9966950165249, 664.5805394129042, 712.0743034055727, 724.3770357492556, 15364.0, 15371.692566148684, 15381.077135371885, 15392.769108463383, 17173.91413042933, 16271.755923661125, 16350.182490875439, 16368.345266189368, 16382.935109217893, 16390.26243819028, 734.3390948146657, 747.6859718918067, 900.4507250577126, 911.3165126155384, 935.9251259899225, 909.5315912305168, 912.8402529557334, 913.4793167894303, 916.9958895009953, 917.1287277086761, 976.7216343342149, 979.1530326267798, 980.13258266434, 981.6760469045198, 982.5480279071636, 768.8654485465049, 952.8808898887639, 968.5786682793008, 969.1084202533651, 972.0619602084023, 618.7153909201772, 725.0755287009106, 725.5610355734757, 725.905632267807, 727.2000799120977, 15227.238638068053, 15396.538103856903, 15403.614909627237, 15414.998025128443, 15433.3826646934, 11414.771704565863, 11620.0, 12286.201396909262, 12286.877131228663, 12448.315342656151, 9939.65211217604, 10079.496025198783, 10285.434301113435, 10395.688129356131, 10529.894701052968, 2943.6026136471514, 3472.5485686860548, 3552.378333791576, 3565.8217089145437, 3715.3312403767313, 78978.0, 79552.60223698903, 79612.80580791293, 82744.0, 84796.0, 8812.8678069829, 9014.368994170476, 9082.987592953927, 9220.07799220086, 9322.0, 19542.31601893927, 19569.315073972342, 19576.412707618794, 19596.608067838562, 19603.01984900749, 7265.5277406969435, 7315.231900650355, 7448.441366897504, 7450.739224127129, 7540.622968851536, 4157.417961485395, 4182.581741825793, 4205.369194620831, 4220.725652832556, 4392.956070439319, 3608.9278214435562, 3643.6720695137033, 3662.1393972416463, 3662.61542538035, 3663.7618554794385, 534.708772908087, 567.3900556901348, 644.291279592454, 662.5825729790298, 664.315754772585, 540.284123536316, 556.7466802604805, 586.4663156527624, 600.1058422949774, 603.0863242188088, 7599.696012159562, 7691.888382879821, 7875.645595948196, 8026.558539280279, 8153.5923203839575, 513.2916575126302, 535.7910414938177, 590.0824218340522, 592.733270028489, 601.1073555769678, 3643.690286325639, 3750.099976005739, 3815.294170578452, 3830.616938306147, 3901.464048368583, 81597.59201204075, 82184.76722849162, 82257.35485290381, 82425.58787206025, 86395.56802216075, 83875.0, 84156.0, 84848.45476476417, 85583.0, 87287.0, 66646.33353666498, 66753.3324666747, 66889.66555167193, 67235.32764672389, 68212.0, 7328.377087947584, 7506.549607023596, 7522.661480233293, 7553.509021913558, 7677.424193185645, 32187.839060804545, 50491.232806851585, 50684.0, 51083.23375149301, 51241.48758512367, 68826.65586672035, 71836.0, 71992.0, 72821.0, 73462.63268683622, 9763.56063977137, 9812.0, 9996.550155242887, 10180.440075795903, 10574.84137737919, 10688.144948403953, 10878.456077196266, 10946.288491248044, 11031.39327336972, 11292.491837867152, 8297.092550050753, 10323.741906452398, 11599.188056835941, 11778.705532361417, 12104.636860894187, 11200.719982000515, 11490.655280341603, 11493.425328733698, 11807.0, 11895.82156267674, 10964.725881852699, 11230.494627741935, 11235.4382280884, 11473.196876218584, 11583.536658533565, 9442.480663563296, 9593.520323983912, 9747.268954828558, 9771.706848794547, 9813.85279220798, 9573.138417542455, 9653.758656033375, 9710.70867873965, 9721.951390243003, 9746.707598772047], "value": 6809.9651645881295, "unit": "score"}], "name": "dromaeo_css", "value": 7590.433475096899, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 119.0, 113.0, 112.0, 112.0, 114.0, 113.0, 115.0, 136.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 160.0, 156.0, 119.0, 141.0, 117.0, 156.0, 157.0, 116.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 186.0, 186.0, 184.0, 187.0, 183.0, 186.0, 186.0, 185.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 103.0, 63.0, 171.0, 45.0, 66.0, 73.0, 74.0, 156.0, 46.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 143.0, 77.0, 84.0, 93.0, 126.0, 79.0, 75.0, 137.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 88.0, 89.0, 84.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 89.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 65.0, 62.0, 63.0, 62.0, 83.0, 57.0, 58.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 72.0, 76.0, 74.0, 70.0, 69.0, 70.0, 71.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 81.0, 80.0, 80.0, 79.0, 81.0, 85.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 146.0, 138.0, 125.0, 130.0, 131.0, 132.0, 165.0, 159.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 177.0, 212.0, 221.0, 167.0, 170.0, 164.0, 174.0, 163.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 56.0, 81.0, 89.0, 97.0, 99.0, 66.0, 67.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1502.1999999999998, "alertThreshold": 2.0}]} 06:15:48 INFO - Return code: 0 06:15:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:15:48 ERROR - # TBPL SUCCESS # 06:15:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:48 INFO - 2016-05-09 06:15:48.886 screenresolution[2010:15233] starting screenresolution argv=screenresolution get 06:15:48 INFO - 2016-05-09 06:15:48.889 screenresolution[2010:15233] Display 0: 1600x1200x32@60 06:15:48 INFO - 2016-05-09 06:15:48.895 screenresolution[2011:15236] starting screenresolution argv=screenresolution list 06:15:48 INFO - Available Modes on Display 0 06:15:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:49 INFO - Intel Iris: 06:15:49 INFO - Chipset Model: Intel Iris 06:15:49 INFO - Type: GPU 06:15:49 INFO - Bus: Built-In 06:15:49 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:49 INFO - Vendor: Intel (0x8086) 06:15:49 INFO - Device ID: 0x0a2e 06:15:49 INFO - Revision ID: 0x0009 06:15:49 INFO - Displays: 06:15:49 INFO - Display: 06:15:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:49 INFO - Display Serial Number: 1600x1200 60 06:15:49 INFO - Main Display: Yes 06:15:49 INFO - Mirror: Off 06:15:49 INFO - Online: Yes 06:15:49 INFO - Rotation: Supported 06:15:49 INFO - Return code: 0 06:15:49 INFO - Running post-action listener: _resource_record_post_action 06:15:49 INFO - Running post-run listener: _resource_record_post_run 06:15:50 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 1204224; Write bytes: 649927168; Read time: 16; Write time: 2026 06:15:50 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344556032; Write bytes: 346023936; Read time: 26384; Write time: 639 06:15:50 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1200128; Write bytes: 293949952; Read time: 16; Write time: 1353 06:15:50 INFO - Running post-run listener: _upload_blobber_files 06:15:50 INFO - Blob upload gear active. 06:15:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:50 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:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:51 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3. 06:15:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:51 INFO - (blobuploader) - INFO - Done attempting. 06:15:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:52 INFO - (blobuploader) - INFO - Done attempting. 06:15:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:52 INFO - Return code: 0 06:15:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a06cf9f18b9f74d6207375cf3a74b831e07989a42d3efd19e812b7519f953c1b6aa6c77d14d15f8784eff6b1620d7d7f26cbea3fc22c56c49a120a9b5794696b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44a5d27f049f275717604904c711e5f1b21b103007646f08701fa8c5413f28250931459d655d5158c717b2b2ba8ab5ce8880a789a8ba392135a71da8ea8ab06c"} 06:15:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:52 INFO - Contents: 06:15:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a06cf9f18b9f74d6207375cf3a74b831e07989a42d3efd19e812b7519f953c1b6aa6c77d14d15f8784eff6b1620d7d7f26cbea3fc22c56c49a120a9b5794696b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44a5d27f049f275717604904c711e5f1b21b103007646f08701fa8c5413f28250931459d655d5158c717b2b2ba8ab5ce8880a789a8ba392135a71da8ea8ab06c"} 06:15:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:52 INFO - Copying logs to upload dir... 06:15:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.399079 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-09 06:15:52.538508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:52.541699) ========= 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.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a06cf9f18b9f74d6207375cf3a74b831e07989a42d3efd19e812b7519f953c1b6aa6c77d14d15f8784eff6b1620d7d7f26cbea3fc22c56c49a120a9b5794696b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44a5d27f049f275717604904c711e5f1b21b103007646f08701fa8c5413f28250931459d655d5158c717b2b2ba8ab5ce8880a789a8ba392135a71da8ea8ab06c"} build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a06cf9f18b9f74d6207375cf3a74b831e07989a42d3efd19e812b7519f953c1b6aa6c77d14d15f8784eff6b1620d7d7f26cbea3fc22c56c49a120a9b5794696b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44a5d27f049f275717604904c711e5f1b21b103007646f08701fa8c5413f28250931459d655d5158c717b2b2ba8ab5ce8880a789a8ba392135a71da8ea8ab06c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:52.570095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:52.570423) ========= 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.iJg1VmgR4b/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.SM52hbTzh9/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005136 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:52.619749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:52.620168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:52.620592) ========= ========= Total master_lag: 0.16 =========