builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1461619105.12 results: success (0) buildid: 20160425095909 builduid: bf4af95f322a4411b3423b15fcf5776e revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.124366) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.124766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.125037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.142496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.142794) ========= 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.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-04-25 14:18:25-- 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% 150M=0s 2016-04-25 14:18:25 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.249770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.250076) ========= 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.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.020628 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:25.301735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:18:25.305130) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dcaf0a6fa115ad73bf7505a8e76464250b971a04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-04-25 14:18:25,333 truncating revision to first 12 chars 2016-04-25 14:18:25,333 Setting DEBUG logging. 2016-04-25 14:18:25,333 attempt 1/10 2016-04-25 14:18:25,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dcaf0a6fa115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:18:26,635 unpacking tar archive at: mozilla-beta-dcaf0a6fa115/testing/mozharness/ program finished with exit code 0 elapsedTime=1.552824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 14:18:26.875054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:26.875375) ========= script_repo_revision: dcaf0a6fa115ad73bf7505a8e76464250b971a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:26.875741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:26.875996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:18:26.893079) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-25 14:18:26.893359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:18:27 INFO - MultiFileLogger online at 20160425 14:18:27 in /builds/slave/test 14:18:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:18:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:27 INFO - {'append_to_log': False, 14:18:27 INFO - 'base_work_dir': '/builds/slave/test', 14:18:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:18:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:27 INFO - 'branch': 'Mozilla-Beta', 14:18:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:27 INFO - 'config_files': ('talos/mac_config.py',), 14:18:27 INFO - 'default_actions': ('clobber', 14:18:27 INFO - 'read-buildbot-config', 14:18:27 INFO - 'download-and-extract', 14:18:27 INFO - 'populate-webroot', 14:18:27 INFO - 'create-virtualenv', 14:18:27 INFO - 'install', 14:18:27 INFO - 'run-tests'), 14:18:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:27 INFO - 'download_minidump_stackwalk': True, 14:18:27 INFO - 'download_symbols': 'ondemand', 14:18:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:27 INFO - 'installer_path': 'installer.exe', 14:18:27 INFO - 'log_level': 'info', 14:18:27 INFO - 'log_name': 'talos', 14:18:27 INFO - 'log_to_console': True, 14:18:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:18:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:18:27 INFO - 'opt_config_files': (), 14:18:27 INFO - 'pip_index': False, 14:18:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:27 INFO - 'cmd': ('bash', 14:18:27 INFO - '-c', 14:18:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:27 INFO - 'enabled': True, 14:18:27 INFO - 'halt_on_failure': False, 14:18:27 INFO - 'name': 'check_screen_resolution'},), 14:18:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:18:27 INFO - 'cmd': ('bash', 14:18:27 INFO - '-c', 14:18:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:18:27 INFO - 'enabled': True, 14:18:27 INFO - 'halt_on_failure': False, 14:18:27 INFO - 'name': 'check_screen_resolution'},), 14:18:27 INFO - 'run_cmd_checks_enabled': True, 14:18:27 INFO - 'sps_profile': False, 14:18:27 INFO - 'sps_profile_interval': 0, 14:18:27 INFO - 'suite': 'dromaeojs-e10s', 14:18:27 INFO - 'system_bits': '32', 14:18:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:27 INFO - 'title': 't-yosemite-r7-0153', 14:18:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:27 INFO - 'use_talos_json': True, 14:18:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:27 INFO - 'work_dir': 'build'} 14:18:27 INFO - ##### 14:18:27 INFO - ##### Running clobber step. 14:18:27 INFO - ##### 14:18:27 INFO - Running pre-action listener: _resource_record_pre_action 14:18:27 INFO - Running main action method: clobber 14:18:27 INFO - rmtree: /builds/slave/test/build 14:18:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:28 INFO - Running post-action listener: _resource_record_post_action 14:18:28 INFO - ##### 14:18:28 INFO - ##### Running read-buildbot-config step. 14:18:28 INFO - ##### 14:18:28 INFO - Running pre-action listener: _resource_record_pre_action 14:18:28 INFO - Running main action method: read_buildbot_config 14:18:28 INFO - Using buildbot properties: 14:18:28 INFO - { 14:18:28 INFO - "project": "", 14:18:28 INFO - "product": "firefox", 14:18:28 INFO - "script_repo_revision": "production", 14:18:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:18:28 INFO - "repository": "", 14:18:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:18:28 INFO - "buildid": "20160425095909", 14:18:28 INFO - "pgo_build": "False", 14:18:28 INFO - "basedir": "/builds/slave/test", 14:18:28 INFO - "buildnumber": 1, 14:18:28 INFO - "slavename": "t-yosemite-r7-0153", 14:18:28 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:18:28 INFO - "platform": "yosemite_r7", 14:18:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:18:28 INFO - "branch": "mozilla-beta", 14:18:28 INFO - "repo_path": "releases/mozilla-beta", 14:18:28 INFO - "revision": "dcaf0a6fa115ad73bf7505a8e76464250b971a04", 14:18:28 INFO - "stage_platform": "macosx64", 14:18:28 INFO - "builduid": "bf4af95f322a4411b3423b15fcf5776e", 14:18:28 INFO - "slavebuilddir": "test" 14:18:28 INFO - } 14:18:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:18:28 INFO - Running post-action listener: _resource_record_post_action 14:18:28 INFO - ##### 14:18:28 INFO - ##### Running download-and-extract step. 14:18:28 INFO - ##### 14:18:28 INFO - Running pre-action listener: _resource_record_pre_action 14:18:28 INFO - Running main action method: download_and_extract 14:18:28 INFO - mkdir: /builds/slave/test/build/tests 14:18:28 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')]} 14:18:28 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 14:18:29 INFO - Downloaded 1241 bytes. 14:18:29 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:18:29 INFO - Using the following test package requirements: 14:18:29 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:29 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:18:29 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:18:29 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:18:29 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:18:29 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:29 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:18:29 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:18:29 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:18:29 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:18:29 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:18:29 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:18:29 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:29 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:18:31 INFO - Downloaded 17745658 bytes. 14:18:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:18:34 INFO - Return code: 0 14:18:34 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:18:34 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')]} 14:18:34 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:18:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 14:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 14:18:35 INFO - Downloaded 17745658 bytes. 14:18:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:18:39 INFO - Return code: 0 14:18:39 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')]} 14:18:39 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 14:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 14:18:40 INFO - Downloaded 10845194 bytes. 14:18:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:18:40 INFO - Return code: 0 14:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:18:40 INFO - https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 14:18:43 INFO - Downloaded 88300452 bytes. 14:18:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:43 INFO - mkdir: /builds/slave/test/properties 14:18:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:43 INFO - Contents: 14:18:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:18:45 INFO - Running post-action listener: _resource_record_post_action 14:18:45 INFO - Running post-action listener: set_extra_try_arguments 14:18:45 INFO - ##### 14:18:45 INFO - ##### Running populate-webroot step. 14:18:45 INFO - ##### 14:18:45 INFO - Running pre-action listener: _resource_record_pre_action 14:18:45 INFO - Running main action method: populate_webroot 14:18:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:45 INFO - '--tppagecycles', 14:18:45 INFO - '7'], 14:18:45 INFO - 'tests': ['tsvgm']}}, 14:18:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:18:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:18:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'tests': ['damp', 'tps']}, 14:18:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['damp', 'tps']}, 14:18:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:18:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:45 INFO - 'other': {'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'other_l64': {'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'other_nol64': {'tests': ['a11yr', 14:18:45 INFO - 'ts_paint', 14:18:45 INFO - 'tpaint', 14:18:45 INFO - 'sessionrestore', 14:18:45 INFO - 'sessionrestore_no_auto_restore', 14:18:45 INFO - 'tabpaint']}, 14:18:45 INFO - 'svgr': {'tests': ['tsvgx', 14:18:45 INFO - 'tsvgr_opacity', 14:18:45 INFO - 'tart', 14:18:45 INFO - 'tscrollx', 14:18:45 INFO - 'cart']}, 14:18:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['tsvgx', 14:18:45 INFO - 'tsvgr_opacity', 14:18:45 INFO - 'tart', 14:18:45 INFO - 'tscrollx', 14:18:45 INFO - 'cart']}, 14:18:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'tests': ['tp5o']}, 14:18:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'talos_options': ['--e10s'], 14:18:45 INFO - 'tests': ['tp5o']}, 14:18:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'talos_options': ['--xperf_path', 14:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:45 INFO - 'tests': ['tp5n']}, 14:18:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:45 INFO - 'talos_options': ['--e10s', 14:18:45 INFO - '--xperf_path', 14:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:45 INFO - 'tests': ['tp5n']}}, 14:18:45 INFO - 'talos.zip': {'path': '', 14:18:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:45 INFO - Running post-action listener: _resource_record_post_action 14:18:45 INFO - ##### 14:18:45 INFO - ##### Running create-virtualenv step. 14:18:45 INFO - ##### 14:18:45 INFO - Running pre-action listener: _resource_record_pre_action 14:18:45 INFO - Running main action method: create_virtualenv 14:18:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:45 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 14:18:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:45 INFO - Using real prefix '/tools/python27' 14:18:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:48 INFO - Installing pip.................done. 14:18:48 INFO - Return code: 0 14:18:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:48 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')]} 14:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:48 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')]} 14:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:48 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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:18:48 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 14:18:48 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 14:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:48 INFO - 'HOME': '/Users/cltbld', 14:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:48 INFO - 'LOGNAME': 'cltbld', 14:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:48 INFO - 'MOZ_NO_REMOTE': '1', 14:18:48 INFO - 'NO_EM_RESTART': '1', 14:18:48 INFO - 'PAGER': '/bin/cat', 14:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:48 INFO - 'PWD': '/builds/slave/test', 14:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:48 INFO - 'SHELL': '/bin/bash', 14:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:18:48 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:48 INFO - 'USER': 'cltbld', 14:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:48 INFO - 'XPC_FLAGS': '0x0', 14:18:48 INFO - 'XPC_SERVICE_NAME': '0', 14:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:49 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 14:18:49 INFO - Cleaning up... 14:18:49 INFO - Return code: 0 14:18:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:49 INFO - 'HOME': '/Users/cltbld', 14:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:49 INFO - 'LOGNAME': 'cltbld', 14:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:49 INFO - 'MOZ_NO_REMOTE': '1', 14:18:49 INFO - 'NO_EM_RESTART': '1', 14:18:49 INFO - 'PAGER': '/bin/cat', 14:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:49 INFO - 'PWD': '/builds/slave/test', 14:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:49 INFO - 'SHELL': '/bin/bash', 14:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:18:49 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:49 INFO - 'USER': 'cltbld', 14:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:49 INFO - 'XPC_FLAGS': '0x0', 14:18:49 INFO - 'XPC_SERVICE_NAME': '0', 14:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:49 INFO - Downloading/unpacking psutil>=0.7.1 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:51 INFO - Installing collected packages: psutil 14:18:51 INFO - Running setup.py install for psutil 14:18:52 INFO - building 'psutil._psutil_osx' extension 14:18:52 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 14:18:52 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 14:18:52 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 14:18:52 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 14:18:52 INFO - building 'psutil._psutil_posix' extension 14:18:52 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 14:18:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:18:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:18:52 INFO - ^ 14:18:52 INFO - 1 warning generated. 14:18:52 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 14:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:52 INFO - Successfully installed psutil 14:18:52 INFO - Cleaning up... 14:18:52 INFO - Return code: 0 14:18:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:52 INFO - 'HOME': '/Users/cltbld', 14:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:52 INFO - 'LOGNAME': 'cltbld', 14:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:52 INFO - 'MOZ_NO_REMOTE': '1', 14:18:52 INFO - 'NO_EM_RESTART': '1', 14:18:52 INFO - 'PAGER': '/bin/cat', 14:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:52 INFO - 'PWD': '/builds/slave/test', 14:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:52 INFO - 'SHELL': '/bin/bash', 14:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:18:52 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:52 INFO - 'USER': 'cltbld', 14:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:52 INFO - 'XPC_FLAGS': '0x0', 14:18:52 INFO - 'XPC_SERVICE_NAME': '0', 14:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:55 INFO - Installing collected packages: mozsystemmonitor 14:18:55 INFO - Running setup.py install for mozsystemmonitor 14:18:55 INFO - Successfully installed mozsystemmonitor 14:18:55 INFO - Cleaning up... 14:18:55 INFO - Return code: 0 14:18:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:18:55 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 14:18:55 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 14:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:55 INFO - 'HOME': '/Users/cltbld', 14:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:55 INFO - 'LOGNAME': 'cltbld', 14:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:55 INFO - 'MOZ_NO_REMOTE': '1', 14:18:55 INFO - 'NO_EM_RESTART': '1', 14:18:55 INFO - 'PAGER': '/bin/cat', 14:18:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:55 INFO - 'PWD': '/builds/slave/test', 14:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:55 INFO - 'SHELL': '/bin/bash', 14:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:18:55 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:55 INFO - 'USER': 'cltbld', 14:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:55 INFO - 'XPC_FLAGS': '0x0', 14:18:55 INFO - 'XPC_SERVICE_NAME': '0', 14:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:58 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:59 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 14:18:59 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 14:18:59 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 14:18:59 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 14:18:59 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 14:18:59 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 14:18:59 INFO - Downloading docopt-0.6.1.tar.gz 14:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:59 INFO - Running setup.py install for blobuploader 14:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:59 INFO - Running setup.py install for requests 14:19:00 INFO - Running setup.py install for docopt 14:19:00 INFO - Successfully installed blobuploader requests docopt 14:19:00 INFO - Cleaning up... 14:19:00 INFO - Return code: 0 14:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:00 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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:19:00 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 14:19:00 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 14:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:00 INFO - 'HOME': '/Users/cltbld', 14:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:00 INFO - 'LOGNAME': 'cltbld', 14:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:00 INFO - 'MOZ_NO_REMOTE': '1', 14:19:00 INFO - 'NO_EM_RESTART': '1', 14:19:00 INFO - 'PAGER': '/bin/cat', 14:19:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:00 INFO - 'PWD': '/builds/slave/test', 14:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:00 INFO - 'SHELL': '/bin/bash', 14:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:00 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:00 INFO - 'USER': 'cltbld', 14:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:00 INFO - 'XPC_FLAGS': '0x0', 14:19:00 INFO - 'XPC_SERVICE_NAME': '0', 14:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EDSgJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-qFvLyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5sbASj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-GCeQiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-hMb4VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0TFHaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-lkF7eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iknotW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ORd8kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-YOFZTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-xevt4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-FjIjyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-OQa1RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XaRL0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-sJtULT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XmZpHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:02 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-t6JgS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:19:02 INFO - Running setup.py install for manifestparser 14:19:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:19:02 INFO - Running setup.py install for mozcrash 14:19:02 INFO - Running setup.py install for mozdebug 14:19:03 INFO - Running setup.py install for mozdevice 14:19:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Running setup.py install for mozfile 14:19:03 INFO - Running setup.py install for mozhttpd 14:19:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Running setup.py install for mozinfo 14:19:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Running setup.py install for mozInstall 14:19:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:19:03 INFO - Running setup.py install for mozleak 14:19:03 INFO - Running setup.py install for mozlog 14:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Running setup.py install for moznetwork 14:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Running setup.py install for mozprocess 14:19:04 INFO - Running setup.py install for mozprofile 14:19:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Running setup.py install for mozrunner 14:19:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Running setup.py install for mozscreenshot 14:19:04 INFO - Running setup.py install for moztest 14:19:05 INFO - Running setup.py install for mozversion 14:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:19:05 INFO - Cleaning up... 14:19:05 INFO - Return code: 0 14:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:05 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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:19:05 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 14:19:05 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 14:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:05 INFO - 'HOME': '/Users/cltbld', 14:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:05 INFO - 'LOGNAME': 'cltbld', 14:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:05 INFO - 'MOZ_NO_REMOTE': '1', 14:19:05 INFO - 'NO_EM_RESTART': '1', 14:19:05 INFO - 'PAGER': '/bin/cat', 14:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:05 INFO - 'PWD': '/builds/slave/test', 14:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:05 INFO - 'SHELL': '/bin/bash', 14:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:05 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:05 INFO - 'USER': 'cltbld', 14:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:05 INFO - 'XPC_FLAGS': '0x0', 14:19:05 INFO - 'XPC_SERVICE_NAME': '0', 14:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:19:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-mINPnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:19:05 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)) 14:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:19:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fMcpby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:19:05 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)) 14:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:19:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-osyGr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:19:05 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)) 14:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:19:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-yt96kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:19:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-8guzIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Ifi1Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Gob1j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-q4VYnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Xb6GWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-OwX0PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-sn21dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-zU2VpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-aYj5JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6qRSAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:19:06 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)) 14:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-IHPxjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:19:07 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)) 14:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:19:07 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Z281uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:19:07 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)) 14:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:19:07 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-joCuyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:19:07 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)) 14:19:07 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)) 14:19:07 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)) 14:19:07 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)) 14:19:07 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)) 14:19:07 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)) 14:19:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:09 INFO - Downloading blessings-1.6.tar.gz 14:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:19:09 INFO - Installing collected packages: blessings 14:19:09 INFO - Running setup.py install for blessings 14:19:09 INFO - Successfully installed blessings 14:19:09 INFO - Cleaning up... 14:19:10 INFO - Return code: 0 14:19:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:10 INFO - Reading from file tmpfile_stdout 14:19:10 INFO - Current package versions: 14:19:10 INFO - blessings == 1.6 14:19:10 INFO - blobuploader == 1.2.4 14:19:10 INFO - docopt == 0.6.1 14:19:10 INFO - manifestparser == 1.1 14:19:10 INFO - mozInstall == 1.12 14:19:10 INFO - mozcrash == 0.17 14:19:10 INFO - mozdebug == 0.1 14:19:10 INFO - mozdevice == 0.48 14:19:10 INFO - mozfile == 1.2 14:19:10 INFO - mozhttpd == 0.7 14:19:10 INFO - mozinfo == 0.9 14:19:10 INFO - mozleak == 0.1 14:19:10 INFO - mozlog == 3.1 14:19:10 INFO - moznetwork == 0.27 14:19:10 INFO - mozprocess == 0.22 14:19:10 INFO - mozprofile == 0.28 14:19:10 INFO - mozrunner == 6.11 14:19:10 INFO - mozscreenshot == 0.1 14:19:10 INFO - mozsystemmonitor == 0.0 14:19:10 INFO - moztest == 0.7 14:19:10 INFO - mozversion == 1.4 14:19:10 INFO - psutil == 3.1.1 14:19:10 INFO - requests == 1.2.3 14:19:10 INFO - wsgiref == 0.1.2 14:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:10 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 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:19:10 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 14:19:10 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 14:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:10 INFO - 'HOME': '/Users/cltbld', 14:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:10 INFO - 'LOGNAME': 'cltbld', 14:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:10 INFO - 'MOZ_NO_REMOTE': '1', 14:19:10 INFO - 'NO_EM_RESTART': '1', 14:19:10 INFO - 'PAGER': '/bin/cat', 14:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:10 INFO - 'PWD': '/builds/slave/test', 14:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:10 INFO - 'SHELL': '/bin/bash', 14:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:10 INFO - 'USER': 'cltbld', 14:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:10 INFO - 'XPC_FLAGS': '0x0', 14:19:10 INFO - 'XPC_SERVICE_NAME': '0', 14:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 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)) 14:19:10 INFO - Cleaning up... 14:19:10 INFO - Return code: 0 14:19:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:19: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', 'jsonschema'] in /builds/slave/test/build 14:19: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 jsonschema 14:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:10 INFO - 'HOME': '/Users/cltbld', 14:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:10 INFO - 'LOGNAME': 'cltbld', 14:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:10 INFO - 'MOZ_NO_REMOTE': '1', 14:19:10 INFO - 'NO_EM_RESTART': '1', 14:19:10 INFO - 'PAGER': '/bin/cat', 14:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:10 INFO - 'PWD': '/builds/slave/test', 14:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:10 INFO - 'SHELL': '/bin/bash', 14:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:10 INFO - 'USER': 'cltbld', 14:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:10 INFO - 'XPC_FLAGS': '0x0', 14:19:10 INFO - 'XPC_SERVICE_NAME': '0', 14:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:10 INFO - Downloading/unpacking jsonschema 14:19:10 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 14:19:10 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 14:19:10 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 14:19:10 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 14:19:10 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 14:19:10 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 14:19:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:13 INFO - Downloading/unpacking functools32 (from jsonschema) 14:19:13 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 14:19:13 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 14:19:13 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 14:19:13 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 14:19:13 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 14:19:13 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 14:19:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:13 INFO - warning: no files found matching '*.txt' 14:19:13 INFO - no previously-included directories found matching 'build' 14:19:13 INFO - no previously-included directories found matching 'dist' 14:19:13 INFO - no previously-included directories found matching '.git*' 14:19:13 INFO - Installing collected packages: jsonschema, functools32 14:19:13 INFO - Running setup.py install for functools32 14:19:13 INFO - warning: no files found matching '*.txt' 14:19:13 INFO - no previously-included directories found matching 'build' 14:19:13 INFO - no previously-included directories found matching 'dist' 14:19:13 INFO - no previously-included directories found matching '.git*' 14:19:13 INFO - Successfully installed jsonschema functools32 14:19:13 INFO - Cleaning up... 14:19:14 INFO - Return code: 0 14:19:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19: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')]} 14:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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')]} 14:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffae15aff20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, '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.mOJhrV94pF/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.RyArTGmLx9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 14:19: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', 'flake8'] in /builds/slave/test/build 14:19: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 flake8 14:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:14 INFO - 'HOME': '/Users/cltbld', 14:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:14 INFO - 'LOGNAME': 'cltbld', 14:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:14 INFO - 'MOZ_NO_REMOTE': '1', 14:19:14 INFO - 'NO_EM_RESTART': '1', 14:19:14 INFO - 'PAGER': '/bin/cat', 14:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:14 INFO - 'PWD': '/builds/slave/test', 14:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:14 INFO - 'SHELL': '/bin/bash', 14:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:14 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:14 INFO - 'USER': 'cltbld', 14:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:14 INFO - 'XPC_FLAGS': '0x0', 14:19:14 INFO - 'XPC_SERVICE_NAME': '0', 14:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:14 INFO - Downloading/unpacking flake8 14:19:14 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 14:19:14 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 14:19:14 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 14:19:14 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 14:19:14 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 14:19:14 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 14:19:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 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 14:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:18 INFO - no previously-included directories found matching 'docs/_build' 14:19:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:18 INFO - Running setup.py install for pep8 14:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:18 INFO - no previously-included directories found matching 'docs/_build' 14:19:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:18 INFO - Cleaning up... 14:19:18 INFO - Return code: 0 14:19:18 INFO - Running post-action listener: _resource_record_post_action 14:19:18 INFO - Running post-action listener: _start_resource_monitoring 14:19:18 INFO - Starting resource monitoring. 14:19:18 INFO - ##### 14:19:18 INFO - ##### Running install step. 14:19:18 INFO - ##### 14:19:18 INFO - Running pre-action listener: _resource_record_pre_action 14:19:18 INFO - Running main action method: install 14:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:18 INFO - Reading from file tmpfile_stdout 14:19:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:18 INFO - Reading from file tmpfile_stdout 14:19:18 INFO - Output received: 14:19:18 INFO - Usage: mozinstall [options] installer 14:19:18 INFO - Options: 14:19:18 INFO - -h, --help show this help message and exit 14:19:18 INFO - -d DEST, --destination=DEST 14:19:18 INFO - Directory to install application into. [default: 14:19:18 INFO - "/builds/slave/test"] 14:19:18 INFO - --app=APP Application being installed. [default: firefox] 14:19:18 INFO - mkdir: /builds/slave/test/build/application 14:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:19:41 INFO - Reading from file tmpfile_stdout 14:19:41 INFO - Output received: 14:19:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:19:41 INFO - Running post-action listener: _resource_record_post_action 14:19:41 INFO - ##### 14:19:41 INFO - ##### Running run-tests step. 14:19:41 INFO - ##### 14:19:41 INFO - Running pre-action listener: _resource_record_pre_action 14:19:41 INFO - Running main action method: run_tests 14:19:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:41 INFO - 2016-04-25 14:19:41.272 screenresolution[1934:10705] starting screenresolution argv=screenresolution get 14:19:41 INFO - 2016-04-25 14:19:41.275 screenresolution[1934:10705] Display 0: 1600x1200x32@60 14:19:41 INFO - 2016-04-25 14:19:41.281 screenresolution[1935:10708] starting screenresolution argv=screenresolution list 14:19:41 INFO - Available Modes on Display 0 14:19:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:41 INFO - Intel Iris: 14:19:41 INFO - Chipset Model: Intel Iris 14:19:41 INFO - Type: GPU 14:19:41 INFO - Bus: Built-In 14:19:41 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:41 INFO - Vendor: Intel (0x8086) 14:19:41 INFO - Device ID: 0x0a2e 14:19:41 INFO - Revision ID: 0x0009 14:19:41 INFO - Displays: 14:19:41 INFO - Display: 14:19:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:41 INFO - Display Serial Number: 1600x1200 60 14:19:41 INFO - Main Display: Yes 14:19:41 INFO - Mirror: Off 14:19:41 INFO - Online: Yes 14:19:41 INFO - Rotation: Supported 14:19:41 INFO - Return code: 0 14:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:41 INFO - Python 2.7.3 14:19:41 INFO - Return code: 0 14:19:41 INFO - grabbing minidump binary from tooltool 14:19:41 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')]} 14:19:41 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 0x104a1ed30>, '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 0x104882db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a15b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:41 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 14:19:41 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 14:19:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:41 INFO - Return code: 0 14:19:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:19:42 INFO - Return code: 0 14:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mOJhrV94pF/Render', 14:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:42 INFO - 'HOME': '/Users/cltbld', 14:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:42 INFO - 'LOGNAME': 'cltbld', 14:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:42 INFO - 'MOZ_NO_REMOTE': '1', 14:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:42 INFO - 'NO_EM_RESTART': '1', 14:19:42 INFO - 'PAGER': '/bin/cat', 14:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:42 INFO - 'PWD': '/builds/slave/test', 14:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:42 INFO - 'SHELL': '/bin/bash', 14:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyArTGmLx9/Listeners', 14:19:42 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 14:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:42 INFO - 'USER': 'cltbld', 14:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:42 INFO - 'XPC_FLAGS': '0x0', 14:19:42 INFO - 'XPC_SERVICE_NAME': '0', 14:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:19:43 INFO - mozversion application_buildid: 20160425095909 14:19:43 INFO - mozversion application_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:19:43 INFO - mozversion application_display_name: Firefox 14:19:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:43 INFO - mozversion application_name: Firefox 14:19:43 INFO - mozversion application_remotingname: firefox 14:19:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:43 INFO - mozversion application_vendor: Mozilla 14:19:43 INFO - mozversion application_version: 47.0 14:19:43 INFO - mozversion platform_buildid: 20160425095909 14:19:43 INFO - mozversion platform_changeset: dcaf0a6fa115ad73bf7505a8e76464250b971a04 14:19:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:19:43 INFO - mozversion platform_version: 47.0 14:19:43 INFO - using testdate: 1461619183 14:19:43 INFO - actual date: 1461619183 14:19:43 INFO - starting webserver on 'localhost:50276' 14:19:43 INFO - SUITE-START | Running 2 tests 14:19:43 INFO - TEST-START | dromaeo_css 14:19:43 INFO - operating with platform_type : mac_ 14:19:43 INFO - Initialising browser for dromaeo_css test... 14:19:43 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmphZJcay/profile http://localhost:50276/getInfo.html) 14:19:45 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 14:19:45 INFO - PROCESS | 1953 | colorDepth:24 14:19:45 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 14:19:45 INFO - PROCESS | 1953 | __metrics 14:19:45 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:19:46 INFO - TEST-INFO | 1953: exit 0 14:19:46 INFO - Browser initialized. 14:19:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:46 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmphZJcay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:58 INFO - PROCESS | 1957 | RSS: Main: 168280064 14:19:58 INFO - PROCESS | 1957 | 14:20:47 INFO - PROCESS | 1957 | 1461619247798 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] 14:22:57 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50276/tests/dromaeo/cssquery-ext.html) 14:22:58 INFO - PROCESS | 1957 | RSS: Main: 178098176 14:22:58 INFO - PROCESS | 1957 | 14:26:00 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-ext.html (next: http://localhost:50276/tests/dromaeo/cssquery-jquery.html) 14:26:01 INFO - PROCESS | 1957 | RSS: Main: 190029824 14:26:01 INFO - PROCESS | 1957 | 14:29:03 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50276/tests/dromaeo/cssquery-mootools.html) 14:29:03 INFO - PROCESS | 1957 | RSS: Main: 191496192 14:29:03 INFO - PROCESS | 1957 | 14:32:05 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50276/tests/dromaeo/cssquery-prototype.html) 14:32:05 INFO - PROCESS | 1957 | RSS: Main: 195510272 14:32:05 INFO - PROCESS | 1957 | 14:35:08 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50276/tests/dromaeo/cssquery-yui.html) 14:35:09 INFO - PROCESS | 1957 | RSS: Main: 194715648 14:35:09 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:50276/tests/dromaeo/cssquery-yui.html (next: http://localhost:50276/tests/dromaeo/cssquery-dojo.html) 14:38:11 INFO - PROCESS | 1957 | RSS: Main: 199774208 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | __start_tp_report 14:38:11 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 14:38:11 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 14:38:11 INFO - PROCESS | 1957 | |i|pagename|runs| 14:38:11 INFO - PROCESS | 1957 | |0;dojo.html;2926.487864623691;3656.1773600939773;3681.374166391713;3683.723720720945;3706.8887933361993;5841.744025034617;5927.73325200366;5936.673482958447;5965.403459654032;6011.428914253144;4917.950820491803;5970.373110823366;6022.976094064009;6023.096535519674;6036.939630603692;5243.292155559008;5314.707691076989;5413.566914646819;5429.567601394627;5468.152436372348;5285.550728188108;5334.306540149775;5364.973175134119;5421.756020979065;5448.128299472085;4844.66087373884;5061.329761178802;5406.405295417501;5423.918641220384;5464.726763661821;4357.6078152966065;5336.039512887717;5392.218128371364;5463.672179669213;5483.561315094783;4331.761753103609;5174.508421699932;5266.4733526647415;5277.419483856773;5298.231756395339;5692.544596432275;5743.942560574383;5749.741261643236;5757.798477053283;5836.6789826559525;6127.34224287047;6175.228096487939;6230.937690623081;6245.656488893109;6251.12484252205;6238.9376106238815;6308.3060863305;6315.778947736807;6325.5255855811;6336.80989570309;6050.848728781772;6067.029275315972;6072.666003369813;6105.175801266772;6109.6639684817765;6261.060840873905;6357.205349331333;6390.840228994312;6398.8720225595225;6489;6176.320604733476;6193.81418557444;6195.380461953769;6223.1287619733275;6230.06549017651;6315.684215789192;6319.9368006320265;6334.746610135635;6341.619502829845;6348.936510634927;6118.174046503754;6144.433169541828;6146.4775494082605;6172.598781079216;6216.316205217422;6179.227596550431;6189.35011823761;6197.566170368031;6212.782552610637;6242.875142497215;4979.502049794992;4985.4017517897355;4986.177280748709;4993.151164302078;4996.650234483552;4349.739015659071;4452.910941781146;4471.150481408522;4541.545845415432;4599.264117741145;5365.9731701342025;5785.582532279618;5978.611390259619;6008;6066.3023752269055;6229.221347331583;6251.718672659741;6267.561270711098;6272.153259310026;6286.717097730613;5944.821655350346;5995.580309378389;6030.879382412327;6037.09443583466;6076.422739839708;5491.560675145979;5537.418571050062;5552.833414997556;5558.055130627803;5560.555155587544;6385.169927909342;6546.967265163644;6551.672416379257;6574.276829548746;6589.24223714279;6218.968905155626;6274.466670333073;6312.6528040956355;6315.052742088724;6331.841703957438;6451.548391612542;6452.161219041494;6459.644719540471;6476.222853257639;6491.350864913471;6109.175261339662;6123.892747182756;6154.78458253959;6189.6286222826775;6197.5351848610635;6209.441150296495;6217.222847144107;6261.530385221035;6266.342034086355;6301.684915754286;6145.569810113249;6153.292371377349;6160.075988601746;6176.1970943778815;6180.351063138306;4982;6140.723667435065;6153.907691384543;6166.105914642441;6203.503719702323;5851.94148058531;6148.292946311231;6153.569250152446;6173.907391389043;6202.100695399052;5144;6214.378562143749;6228.5951413158;6243.7814676486105;6261.3112557617715;6110.236220472441;6112.07291107;6130.325664177026;6242.1261023455845;6268.341824108586 14:38:11 INFO - PROCESS | 1957 | |1;ext.html;539.8164624027833;603.4599033864691;611.825295432769;619.6746707978308;687.8375545328395;32740;40295.59704402955;40707.18585628289;40754.79622601883;40918.795406023004;35827.10432239189;42153.57846421535;42215;42259.78870105645;42760;9723.12491875731;9854.556544955494;9928.255380846429;9936.900630993707;9943.502824858764;9641.035896410373;10084.243681723863;10120.797584048314;10133.290669653128;10180.23648226386;9685.903140968605;10087.697369078902;10158.085772280494;10160.59357625694;10174;9796.363236389647;10054;10126.645567405105;10130.138938190263;10161.288709790319;9930.354526955725;9969.70090897267;9995.00049995002;10015.248856335804;10046.89953100467;36919;41880.79059604713;42320;42395.152096957885;42763.57236427627;3162.7311678507353;3371.2414706691043;3385.5937287525653;3444.896653100411;3484.6689564491335;28964.71035289641;29216;29356.00097946603;29839.552406713916;30357.544636830466;2547.4777670577487;2837.1914004508617;2840.2757296889163;2879.8992035278666;2937.9559306610417;326607;329516;329841.9999999976;329998;331159;73006.63496682483;73204.63397682978;73759.63120184472;73811;73942;79422;82438.58780706058;82481.58759206286;82642.58678706568;82847.5857620708;18290;18290.268389264547;18625.627487450176;18704.906475467535;18867.245310187438;14008.229547374993;14066.507672231628;14111.576652700436;14206.857931420553;14248.501302454364;23512.177073802675;23798.76201238;23839.284821455385;23899;24298;7863.410244231705;9182.816343673088;9368.657835541115;9376.59351097341;9381.061893810564;983.8179936711731;1033.503918119307;1033.6872172341084;1058.402002868377;1066.0512144191675;31470.213244669067;31698.049058528282;31743.76940442426;31818.04545863628;32092.518612220836;1170.6722117807028;1173.4250217393587;1177.711460692136;1206.1677442564603;1228.9385530723428;15805.920970395304;15916.840831591768;16361;16441.753373699405;17225.7416138758;696586;701017;705597;707815;710093;68923.65538172377;68969.65515172492;69000.6549967247;69277;69304.65347673229;1535.1710076558534;1552.9378824846879;1566.8511491408299;1569.5997520632166;1688.0125126800713;32869;32882.34235315232;32882.34235315232;32910.17724556905;33565.32869342648;57142.142867857845;57800.71099644475;57812.4218757807;57944.42055579559;58023;531980;534542;536617;536645;537485;34394.65605344014;35109.82445087758;48054.27918581154;49074;50282.24576631426;47471;48175.277370840166;48509.27236091532;49042;49240.261396079804;40010.79994600009;40692.79653601713;40751.77744667665;40759;41862.74411767652;39253.607463926135;40473;40626.18747624972;40697.186056278115;40787.18425631411;38495;40806.77579672614;41420;42234.73295801131;42269.36595951002;26653.600195997464;31361.05916822499;31780.841095794374;34181.829090854386;34402.65597343994;21347.893260533598;24950.62574061354;25795.742042579335;25955.351116222246;26418.73581264163 14:38:11 INFO - PROCESS | 1957 | |2;jquery.html;342.31366110947556;373.47526724951433;377.9603141670125;387.15406836063204;387.6298135280807;20535.48661283467;21151.788482115193;21578.676319855174;22110.447238819037;22255.777442225593;22300.88849555754;22822.65766013511;22852.428689282777;22864.314070577868;23266.18568350104;5861.296644402656;5869.8826023479505;6081.604695694788;6156.722947467352;6160.599561028541;5942;5946.43508866657;5956.612820166697;6085.300190478085;6090.14737936687;5334.706591137486;5630.887382252373;5991.191189189447;6004.12940123684;6049.213602231704;5083.593312535007;5860.648361098327;5860.648361098348;5971.98476259037;6009.519238460913;1581.0592697345062;3780.5822816443833;5169.121249387613;5198.532132108091;5233.267342572043;22595.322140335815;26250.474990500275;27057.64711764404;27262.182134535997;27453;2137.444264491228;2483.7143728471096;2617.1886715118376;2686.7313268672974;2721.182744057326;14090.577282681536;14900.956933014693;15523.922380388025;15599.986000910018;15602.765958510632;1803.3507937142617;1836.412348048625;1848.9722654160198;1864.6363959027994;1893.6307420053095;103219;103740.48129759303;105137.94862051358;106327;106650.46674766653;10908.672739817817;11150.275232109887;11156.497957591928;11193.552257909756;11213.271137376045;11675.12436567261;13612.387442565108;13658;13661.931690341484;13705.383257753425;9095.31785116119;9136.81726365469;9140.040295768982;9156.542172891328;9242.76893077665;9393.013733558015;9443.669471568463;9499.38254013487;9556.856647150298;9623.230141588656;5473.151661492475;6419.839504012437;6427.967860160763;6493.902591461132;6511.218653761579;1719.664665390262;1820.3537744100918;1913.0912816412372;1920.2511020701659;1921.9519512012032;999.3703966501204;1035.6323505155713;1066.2152329190185;1102.1568500097433;1142.662914440242;17425;22869.428264293525;23044.65433018506;23069.423264418525;23150.884245578665;1026.8665073540542;1056.7358160459885;1114.8272017837248;1126.813980877096;1173.4602083041896;11654.76690466186;12105.33420661872;12109.273443593413;12124.030077593772;12184.695382615506;695104;697134;705901;713121;718149;96038;100121.28593033302;127237;128385;138688;1043.7599352148895;1070.7376692710336;1077.21363404715;1079.2013909706761;1085.0885256384674;19038.048097595343;19489.41531753993;19675.31136410219;19765.703514447006;19966.401007969784;54668.633284168216;55367;56307.436925630216;57588.71205643945;57695.42304576901;78112.09439528115;78424.8236276445;83199.5840020796;83294;84357.57821210855;8277.461964972257;8327.833443331221;8337.916620833714;8415.705450309455;8418.831623367621;9632.629447497842;13678.974076944469;13780.353752373177;13829.792553111913;14170.92914535462;11648.242864213798;11962.401879905796;12027.579034733742;12126.908578227649;12162.209456385306;10311.690649280534;11564.479598417924;11748.58879939198;11897.40512974365;12013.45939432745;11319.377434241196;12054.15620906528;12174.39128043612;12217.633470995885;12299.139060265696;8211.95894020526;8223.383246256675;8355.95822020886;8358.749237522885;8534.615942282737;10495.317804342692;11712.414379280832;11887.811218878043;11974.341411222467;12098.213616114925 14:38:11 INFO - PROCESS | 1957 | |3;mootools.html;1532.3870451819275;1573.921303934803;1746.2491128814604;1773.5920738230216;2019.7879222681618;7454.440916931225;8369;8934.240589549896;9022.729318120451;9029.954850225748;8983.820323593523;9018.233450156727;9018.458892466457;9129.68046118386;9140.908590914089;2185.486410693494;2578.9999999999955;2609.621604867293;2610.412657152135;2614.6600941877623;2552.808539359546;2584.2247325802277;2593.9740602594015;2595.1436026111337;2626.2909014566058;2572.87135643218;2588.430545280045;2593.8314009589412;2597.844129352245;2603.830751001188;2586.5473542130144;2589.184406911817;2611.621314909337;2620.489004644095;2621.25294291128;2194.3526659635445;2567.1785028790796;2596.81822272441;2610.3213164577155;2613.2160351894354;9167.358284920057;9180.954095229548;9192.17270445663;9252.953735231347;9258.398204116778;5654.717264136818;5824.592278540504;5847.590668653196;5859.912101318484;5867.882642347172;3681.668649821502;3793.4499497572697;3833.9456649421354;3840.8847734568008;3863.768173909574;1073.1146803886747;1091.7761858818924;1093.4860615510697;1129.610284451871;1132.5469812075153;12347.506099756;12387.69030774238;12404.379781010914;12426.068044896669;12467.563635272812;5091.8981620367385;5109.182530795055;5164.767585458663;5173.948260517422;5189.117849965515;10635.574577016987;10681.946590266998;10716.78566428667;10792.676219713421;10929.672109836718;5817.592768506164;5832.066869300977;5850.297964244318;5878.882422351529;5889.94110058894;4736.95263047372;5120.334356533627;5206.453322401169;5215.739213039333;5310.017646735367;4128.70074388312;4129.318662420667;4145.150244199932;4165.437665915123;4179.791010449465;1378.3521744779937;1391.3599744117616;1398.7482253194523;1401.1803095189225;1405.6345350208815;1401.9579412617638;1446.197360464931;1448.3844366144347;1451.3178805961181;1457.154850186889;8631.741047768577;8643.956780216184;8682.348823838238;8686.739397818075;8687.478751274944;535.3923297057868;545.1414022913926;545.3510322715955;546.8277492589901;552.7236381809096;5429.4299098594865;6341.207349081365;6355;6364.981602943507;6402.743890244338;10989.450527473755;11304.830427543593;11383.601573944872;11417.42912854354;11511.366874821797;10906.236563440641;11185.832212516818;11243.156763242627;11253.437328133561;11350;8741.562921853882;8789.560521973875;8808.163224493663;8819.867701984474;8847.955760221157;8147.10381858007;8178.304844088319;8206.22040906113;8293.880326155891;8322.833543328978;9676.12914837668;9803;9812.067853553901;10075.949620252146;10203.642872499428;9968.451735154345;10105.44420056904;10155.238357123097;10229.130523905551;10239.334443261165;5579.944200558105;7571.280728330799;7591.62041897914;7641.617919104134;7642.235776422535;8414.410991230556;8520.659173632985;8533.232009119209;8567.785805354915;8628.827423451621;7583.203763604963;7763.417743669134;7768.53388796674;7813.1405545388825;7851.921480785348;7636.198199189227;7728.729494467667;7729.149793522595;7836.37309015266;7863.646135923783;6973.755918542826;8155.347572194091;8162.510249385056;8275.255227029596;8289.295409889986;7359.337659610661;7409.888851667121;7420.6660700269695;7423.888641670487;7424.888626670712;7448.068991376078;7514;7526;7546.9245307546225;7567.621618918922 14:38:11 INFO - PROCESS | 1957 | |4;prototype.html;342.209496064092;346.36960731468736;347.18758106031896;349.0505824158292;352.78832700379775;6014.969925150368;6914.688839002244;7015.193252775926;7024.824379390518;7070.823229419267;5988.850278743033;6767.661616919159;6898.413634841045;6943.201531823842;6984.755533556327;4922.630802689795;5002.799888004475;5098.770555325001;5099.821506247282;5194.37667479902;5065.493450654942;5085.923711144335;5097.592192624581;5103.8468845934685;5121.308623335839;5004.549590536851;5019.924701129486;5026.120428924942;5039.344885164942;5055.216441451581;5017.824376146836;5049.166887463564;5072.137736584789;5166.664166829181;5178.249153872667;4456.420665313521;4461.639200044017;4467.910641787179;4470.709403888737;4471.597556219956;5061.949380506221;6358.968205158991;6682.665866706694;6696.5647232929705;6728.428083612899;5873.911891321633;5908.704564771744;5937.376575459601;5946.43508866657;5951.851203719898;5947.434993675594;7414.962925185394;7416.480846340758;7417.777466676009;7425.777226683208;3929.332013557702;3979.8607048753156;4758.119747846659;4797.64017698674;4808.591269742076;7722.806929826743;7814.960925195338;7821.687132514692;7860.292573668397;7876.094249161362;4603.079384123122;4675.696079754873;4841.927371089437;4899.975500122548;4908.165611845995;4036.878893633137;4461.843835465743;4965.081459929852;4982.451930287665;4985.476524964899;4665.4168228971375;5897.705114744245;5965.164876917235;5984;5984.700764961822;6968.512204145661;7495;7500.924990750132;7507.474476786681;7522;1511.4332125452954;1725.7583938248656;1726.9050202238745;1727.136431784108;1731.7921849378156;1056.144522936424;1094.6168840905777;1095.1020163465882;1103.5144536404116;1118.1557923767666;6955.095837541087;7011.474139439562;7014.088168538159;7016.5790052597;7033.753818616324;7432.516886402366;7588;7597.886031709529;7619.161892191854;7643.847123057508;6870;7152.105986751656;7155.3202445767565;7161.9641901790155;7162.818135007666;4031.8992025199605;4088.6729061674996;4089.3048181809163;4092.9795351023054;4111.362738775495;6497.415232628991;8078.676852925817;8081.919180808234;8085.312748416332;8087.797805054803;7829.725959591501;7966.402519811038;8015.839683206304;8019.03771547418;8116.553589552514;8163.836723265502;8170.264676179172;8184.427090103635;8217.79455513617;8236.958815206006;7773.989381380385;7792.84414311722;7823.335016523659;7831.021122359705;7845.3723702104835;6379.93620063812;7539.623018848926;7668.309852113337;7672.079350477979;7672.578008209602;7803.609819508888;8135.30849877767;8154.14381489935;8164.1019487857475;8224.218699223564;4838.491958344464;4855.295982082507;4901.019796040735;4904.754762261944;4906.681065730716;7748.922510775045;7757.612119393895;7758.92241077582;7764.61176941162;7773.222677732408;7425.368843648351;7445.851082978418;7449.174952136761;7454.850902982019;7464.402847772274;7039.577625342496;7373.55758654461;7402.629868506446;7422.777316680508;7460.477766556289;5915.763369465345;7181.922711593303;7274.127104747253;7275.963620181865;7281.235470275545;7410.296021877913;7411.221821708858;7424.703011879465;7445.181030086795;7447.180810110775;6995.125609298838;7284.996625927913;7295.306945840137;7298.124225093023;7363.521371110861 14:38:11 INFO - PROCESS | 1957 | |5;yui.html;696.4219697650949;713.4078714666826;714.2571725405581;745.0649434959125;817.3665409307786;15454;15458.07251564907;15467.690646187084;15560.45538406156;15577.376904923789;14511.927440362784;14554.27228638569;14606.634834129152;14629.853701462982;14662;794.7774623105539;964.3731574476611;969.3069455339431;978.9216862651007;1000.7998400319929;978.66236148529;981.1562056631292;981.5681100315874;988.2094324540375;1005.0251256281396;877.8156587116713;916.9816603667923;1022.5735099536142;1042.4527123260273;1060;1017.1862509992051;1031.6234574380371;1034.4052170002278;1037.8598889149944;1057.0961827637336;657.5824351536761;778.2334400615389;788.6687591211705;790.5019837502394;792.9444938854283;15302.311395987095;15818.525444236691;15851.682966340724;15891.205439727968;15915.761263581055;13306.86693133066;13327.866721332759;13330.666733331647;13370.465181392732;13414.597562073153;8499.235068843773;10296.79406411875;10401.531931063044;10427.530761115768;10513.369197848077;3582.7133829293593;3635.909102272464;3646.2707458508403;3699.3341198584244;3862.787546684959;77389;80350;81294;81430.59284703598;81703.18296817015;9810.313278070467;9917.355371900803;10080.29437939352;10081.798364032826;10284.331518451278;22606;22933.655995160087;23077.19229826948;23082.422939426313;24406.65763383031;6846.7945961621235;7894.250046245597;8098.635561399751;8151.225633564802;8153.1439198884445;4209.810558524874;4235.216484950294;4260.978695106566;4343.326784348431;4374.321980093091;3791.905202369963;3823.7132215083425;3827.234553089393;3847.8076096195637;3902.746321489094;614.695725615823;668.4451904918906;678.772611175252;680.452235950065;682.2461180395691;553.2227220754846;576.9134629805562;619.0868469008177;620.6586377492362;640.4652115483531;7475.6708203684975;8132.390070744717;8157.021157461024;8582.742517724479;8599.312055035582;590.2945979554391;617.237711426388;618.5793660311032;619.6437048697018;627.0688028278004;3914.354131568259;3984.561698213194;4047.866597352746;4061.2283666103344;4224.070704445017;78305;97918.51040744751;98168.50915745518;98720;99584.50623240657;62355.505779769206;77212.61393692995;77820.83268750973;84379.5781021091;85185.57407212924;74914.25085749073;75173;75533;81998.59000704958;83295;7305.963470182615;8761.561921904007;8960.68637597681;9055.81888362216;9104.499252541174;51152.74423627858;51191.72020699512;52750.73624631852;53037;56400.614769388245;66322.66838665969;71745.64127179331;72638.63680681563;73497.42759003409;74328.62835685787;11539.653810385702;11656.650300491;11843.348615826213;11897.583584574499;11987.100967427652;12175.33035683046;12184;12288.139830212156;12388.946939509882;12653.74692506163;11960.58137965167;11980.460879260629;12005.459754310903;12247.632571022883;12342.321172335607;11869;12000.459979300778;12018.278903265833;12112.45493952792;12138.635840924786;10750.247482676137;11087.390193539433;11496.82754758696;11715.882841171479;11940.641780746591;9666.371685840399;9891.406515609087;10125.797484050425;10153.543090560795;10209.9489502552;8783.692570760248;9743.392340264061;9896.703098907044;10040.397576145455;10081.899181008095 14:38:11 INFO - PROCESS | 1957 | __end_tp_report 14:38:11 INFO - PROCESS | 1957 | __start_cc_report 14:38:11 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,362 14:38:11 INFO - PROCESS | 1957 | __end_cc_report 14:38:11 INFO - PROCESS | 1957 | __startTimestamp1461620291424__endTimestamp 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | ------- Summary: start ------- 14:38:11 INFO - PROCESS | 1957 | Number of tests: 6 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5829.18 Median:6123.89 stddev:657.79 (10.7%) stddev-sans-first:619.14 14:38:11 INFO - PROCESS | 1957 | Values: 2926.5 3656.2 3681.4 3683.7 3706.9 5841.7 5927.7 5936.7 5965.4 6011.4 4918.0 5970.4 6023.0 6023.1 6036.9 5243.3 5314.7 5413.6 5429.6 5468.2 5285.6 5334.3 5365.0 5421.8 5448.1 4844.7 5061.3 5406.4 5423.9 5464.7 4357.6 5336.0 5392.2 5463.7 5483.6 4331.8 5174.5 5266.5 5277.4 5298.2 5692.5 5743.9 5749.7 5757.8 5836.7 6127.3 6175.2 6230.9 6245.7 6251.1 6238.9 6308.3 6315.8 6325.5 6336.8 6050.8 6067.0 6072.7 6105.2 6109.7 6261.1 6357.2 6390.8 6398.9 6489.0 6176.3 6193.8 6195.4 6223.1 6230.1 6315.7 6319.9 6334.7 6341.6 6348.9 6118.2 6144.4 6146.5 6172.6 6216.3 6179.2 6189.4 6197.6 6212.8 6242.9 4979.5 4985.4 4986.2 4993.2 4996.7 4349.7 4452.9 4471.2 4541.5 4599.3 5366.0 5785.6 5978.6 6008.0 6066.3 6229.2 6251.7 6267.6 6272.2 6286.7 5944.8 5995.6 6030.9 6037.1 6076.4 5491.6 5537.4 5552.8 5558.1 5560.6 6385.2 6547.0 6551.7 6574.3 6589.2 6219.0 6274.5 6312.7 6315.1 6331.8 6451.5 6452.2 6459.6 6476.2 6491.4 6109.2 6123.9 6154.8 6189.6 6197.5 6209.4 6217.2 6261.5 6266.3 6301.7 6145.6 6153.3 6160.1 6176.2 6180.4 4982.0 6140.7 6153.9 6166.1 6203.5 5851.9 6148.3 6153.6 6173.9 6202.1 5144.0 6214.4 6228.6 6243.8 6261.3 6110.2 6112.1 6130.3 6242.1 6268.3 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:68899.44 Median:35468.46 stddev:145829.14 (411.2%) stddev-sans-first:146147.90 14:38:11 INFO - PROCESS | 1957 | Values: 539.8 603.5 611.8 619.7 687.8 32740.0 40295.6 40707.2 40754.8 40918.8 35827.1 42153.6 42215.0 42259.8 42760.0 9723.1 9854.6 9928.3 9936.9 9943.5 9641.0 10084.2 10120.8 10133.3 10180.2 9685.9 10087.7 10158.1 10160.6 10174.0 9796.4 10054.0 10126.6 10130.1 10161.3 9930.4 9969.7 9995.0 10015.2 10046.9 36919.0 41880.8 42320.0 42395.2 42763.6 3162.7 3371.2 3385.6 3444.9 3484.7 28964.7 29216.0 29356.0 29839.6 30357.5 2547.5 2837.2 2840.3 2879.9 2938.0 326607.0 329516.0 329842.0 329998.0 331159.0 73006.6 73204.6 73759.6 73811.0 73942.0 79422.0 82438.6 82481.6 82642.6 82847.6 18290.0 18290.3 18625.6 18704.9 18867.2 14008.2 14066.5 14111.6 14206.9 14248.5 23512.2 23798.8 23839.3 23899.0 24298.0 7863.4 9182.8 9368.7 9376.6 9381.1 983.8 1033.5 1033.7 1058.4 1066.1 31470.2 31698.0 31743.8 31818.0 32092.5 1170.7 1173.4 1177.7 1206.2 1228.9 15805.9 15916.8 16361.0 16441.8 17225.7 696586.0 701017.0 705597.0 707815.0 710093.0 68923.7 68969.7 69000.7 69277.0 69304.7 1535.2 1552.9 1566.9 1569.6 1688.0 32869.0 32882.3 32882.3 32910.2 33565.3 57142.1 57800.7 57812.4 57944.4 58023.0 531980.0 534542.0 536617.0 536645.0 537485.0 34394.7 35109.8 48054.3 49074.0 50282.2 47471.0 48175.3 48509.3 49042.0 49240.3 40010.8 40692.8 40751.8 40759.0 41862.7 39253.6 40473.0 40626.2 40697.2 40787.2 38495.0 40806.8 41420.0 42234.7 42269.4 26653.6 31361.1 31780.8 34181.8 34402.7 21347.9 24950.6 25795.7 25955.4 26418.7 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:38048.24 Median:22448.11 stddev:116487.77 (518.9%) stddev-sans-first:116780.14 14:38:11 INFO - PROCESS | 1957 | Values: 342.3 373.5 378.0 387.2 387.6 20535.5 21151.8 21578.7 22110.4 22255.8 22300.9 22822.7 22852.4 22864.3 23266.2 5861.3 5869.9 6081.6 6156.7 6160.6 5942.0 5946.4 5956.6 6085.3 6090.1 5334.7 5630.9 5991.2 6004.1 6049.2 5083.6 5860.6 5860.6 5972.0 6009.5 1581.1 3780.6 5169.1 5198.5 5233.3 22595.3 26250.5 27057.6 27262.2 27453.0 2137.4 2483.7 2617.2 2686.7 2721.2 14090.6 14901.0 15523.9 15600.0 15602.8 1803.4 1836.4 1849.0 1864.6 1893.6 103219.0 103740.5 105137.9 106327.0 106650.5 10908.7 11150.3 11156.5 11193.6 11213.3 11675.1 13612.4 13658.0 13661.9 13705.4 9095.3 9136.8 9140.0 9156.5 9242.8 9393.0 9443.7 9499.4 9556.9 9623.2 5473.2 6419.8 6428.0 6493.9 6511.2 1719.7 1820.4 1913.1 1920.3 1922.0 999.4 1035.6 1066.2 1102.2 1142.7 17425.0 22869.4 23044.7 23069.4 23150.9 1026.9 1056.7 1114.8 1126.8 1173.5 11654.8 12105.3 12109.3 12124.0 12184.7 695104.0 697134.0 705901.0 713121.0 718149.0 96038.0 100121.3 127237.0 128385.0 138688.0 1043.8 1070.7 1077.2 1079.2 1085.1 19038.0 19489.4 19675.3 19765.7 19966.4 54668.6 55367.0 56307.4 57588.7 57695.4 78112.1 78424.8 83199.6 83294.0 84357.6 8277.5 8327.8 8337.9 8415.7 8418.8 9632.6 13679.0 13780.4 13829.8 14170.9 11648.2 11962.4 12027.6 12126.9 12162.2 10311.7 11564.5 11748.6 11897.4 12013.5 11319.4 12054.2 12174.4 12217.6 12299.1 8212.0 8223.4 8356.0 8358.7 8534.6 10495.3 11712.4 11887.8 11974.3 12098.2 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:6319.43 Median:2922.70 stddev:3344.86 (114.4%) stddev-sans-first:3334.89 14:38:11 INFO - PROCESS | 1957 | Values: 1532.4 1573.9 1746.2 1773.6 2019.8 7454.4 8369.0 8934.2 9022.7 9030.0 8983.8 9018.2 9018.5 9129.7 9140.9 2185.5 2579.0 2609.6 2610.4 2614.7 2552.8 2584.2 2594.0 2595.1 2626.3 2572.9 2588.4 2593.8 2597.8 2603.8 2586.5 2589.2 2611.6 2620.5 2621.3 2194.4 2567.2 2596.8 2610.3 2613.2 9167.4 9181.0 9192.2 9253.0 9258.4 5654.7 5824.6 5847.6 5859.9 5867.9 3681.7 3793.4 3833.9 3840.9 3863.8 1073.1 1091.8 1093.5 1129.6 1132.5 12347.5 12387.7 12404.4 12426.1 12467.6 5091.9 5109.2 5164.8 5173.9 5189.1 10635.6 10681.9 10716.8 10792.7 10929.7 5817.6 5832.1 5850.3 5878.9 5889.9 4737.0 5120.3 5206.5 5215.7 5310.0 4128.7 4129.3 4145.2 4165.4 4179.8 1378.4 1391.4 1398.7 1401.2 1405.6 1402.0 1446.2 1448.4 1451.3 1457.2 8631.7 8644.0 8682.3 8686.7 8687.5 535.4 545.1 545.4 546.8 552.7 5429.4 6341.2 6355.0 6365.0 6402.7 10989.5 11304.8 11383.6 11417.4 11511.4 10906.2 11185.8 11243.2 11253.4 11350.0 8741.6 8789.6 8808.2 8819.9 8848.0 8147.1 8178.3 8206.2 8293.9 8322.8 9676.1 9803.0 9812.1 10075.9 10203.6 9968.5 10105.4 10155.2 10229.1 10239.3 5579.9 7571.3 7591.6 7641.6 7642.2 8414.4 8520.7 8533.2 8567.8 8628.8 7583.2 7763.4 7768.5 7813.1 7851.9 7636.2 7728.7 7729.1 7836.4 7863.6 6973.8 8155.3 8162.5 8275.3 8289.3 7359.3 7409.9 7420.7 7423.9 7424.9 7448.1 7514.0 7526.0 7546.9 7567.6 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:6047.25 Median:6949.15 stddev:1972.56 (28.4%) stddev-sans-first:1931.06 14:38:11 INFO - PROCESS | 1957 | Values: 342.2 346.4 347.2 349.1 352.8 6015.0 6914.7 7015.2 7024.8 7070.8 5988.9 6767.7 6898.4 6943.2 6984.8 4922.6 5002.8 5098.8 5099.8 5194.4 5065.5 5085.9 5097.6 5103.8 5121.3 5004.5 5019.9 5026.1 5039.3 5055.2 5017.8 5049.2 5072.1 5166.7 5178.2 4456.4 4461.6 4467.9 4470.7 4471.6 5061.9 6359.0 6682.7 6696.6 6728.4 5873.9 5908.7 5937.4 5946.4 5951.9 5947.4 7415.0 7416.5 7417.8 7425.8 3929.3 3979.9 4758.1 4797.6 4808.6 7722.8 7815.0 7821.7 7860.3 7876.1 4603.1 4675.7 4841.9 4900.0 4908.2 4036.9 4461.8 4965.1 4982.5 4985.5 4665.4 5897.7 5965.2 5984.0 5984.7 6968.5 7495.0 7500.9 7507.5 7522.0 1511.4 1725.8 1726.9 1727.1 1731.8 1056.1 1094.6 1095.1 1103.5 1118.2 6955.1 7011.5 7014.1 7016.6 7033.8 7432.5 7588.0 7597.9 7619.2 7643.8 6870.0 7152.1 7155.3 7162.0 7162.8 4031.9 4088.7 4089.3 4093.0 4111.4 6497.4 8078.7 8081.9 8085.3 8087.8 7829.7 7966.4 8015.8 8019.0 8116.6 8163.8 8170.3 8184.4 8217.8 8237.0 7774.0 7792.8 7823.3 7831.0 7845.4 6379.9 7539.6 7668.3 7672.1 7672.6 7803.6 8135.3 8154.1 8164.1 8224.2 4838.5 4855.3 4901.0 4904.8 4906.7 7748.9 7757.6 7758.9 7764.6 7773.2 7425.4 7445.9 7449.2 7454.9 7464.4 7039.6 7373.6 7402.6 7422.8 7460.5 5915.8 7181.9 7274.1 7276.0 7281.2 7410.3 7411.2 7424.7 7445.2 7447.2 6995.1 7285.0 7295.3 7298.1 7363.5 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:19023.89 Median:4358.82 stddev:26628.06 (610.9%) stddev-sans-first:26667.20 14:38:11 INFO - PROCESS | 1957 | Values: 696.4 713.4 714.3 745.1 817.4 15454.0 15458.1 15467.7 15560.5 15577.4 14511.9 14554.3 14606.6 14629.9 14662.0 794.8 964.4 969.3 978.9 1000.8 978.7 981.2 981.6 988.2 1005.0 877.8 917.0 1022.6 1042.5 1060.0 1017.2 1031.6 1034.4 1037.9 1057.1 657.6 778.2 788.7 790.5 792.9 15302.3 15818.5 15851.7 15891.2 15915.8 13306.9 13327.9 13330.7 13370.5 13414.6 8499.2 10296.8 10401.5 10427.5 10513.4 3582.7 3635.9 3646.3 3699.3 3862.8 77389.0 80350.0 81294.0 81430.6 81703.2 9810.3 9917.4 10080.3 10081.8 10284.3 22606.0 22933.7 23077.2 23082.4 24406.7 6846.8 7894.3 8098.6 8151.2 8153.1 4209.8 4235.2 4261.0 4343.3 4374.3 3791.9 3823.7 3827.2 3847.8 3902.7 614.7 668.4 678.8 680.5 682.2 553.2 576.9 619.1 620.7 640.5 7475.7 8132.4 8157.0 8582.7 8599.3 590.3 617.2 618.6 619.6 627.1 3914.4 3984.6 4047.9 4061.2 4224.1 78305.0 97918.5 98168.5 98720.0 99584.5 62355.5 77212.6 77820.8 84379.6 85185.6 74914.3 75173.0 75533.0 81998.6 83295.0 7306.0 8761.6 8960.7 9055.8 9104.5 51152.7 51191.7 52750.7 53037.0 56400.6 66322.7 71745.6 72638.6 73497.4 74328.6 11539.7 11656.7 11843.3 11897.6 11987.1 12175.3 12184.0 12288.1 12388.9 12653.7 11960.6 11980.5 12005.5 12247.6 12342.3 11869.0 12000.5 12018.3 12112.5 12138.6 10750.2 11087.4 11496.8 11715.9 11940.6 9666.4 9891.4 10125.8 10153.5 10209.9 8783.7 9743.4 9896.7 10040.4 10081.9 14:38:11 INFO - PROCESS | 1957 | -------- Summary: end -------- 14:38:11 INFO - PROCESS | 1957 | 14:38:11 INFO - TEST-INFO | 1957: exit 0 14:38:11 INFO - TEST-OK | dromaeo_css | took 1108900ms 14:38:11 INFO - TEST-START | kraken 14:38:11 INFO - operating with platform_type : mac_ 14:38:11 INFO - Initialising browser for kraken test... 14:38:11 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpAPIeRq/profile http://localhost:50276/getInfo.html) 14:38:14 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 14:38:14 INFO - PROCESS | 1965 | colorDepth:24 14:38:14 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 14:38:14 INFO - PROCESS | 1965 | __metrics 14:38:14 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:38:15 INFO - TEST-INFO | 1965: exit 0 14:38:15 INFO - Browser initialized. 14:38:15 INFO - Running cycle 1/1 for kraken test... 14:38:15 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpAPIeRq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:27 INFO - PROCESS | 1969 | RSS: Main: 167985152 14:38:27 INFO - PROCESS | 1969 | 14:38:29 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:30 INFO - PROCESS | 1969 | RSS: Main: 179982336 14:38:30 INFO - PROCESS | 1969 | 14:38:32 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-dft) 14:38:33 INFO - PROCESS | 1969 | RSS: Main: 188493824 14:38:33 INFO - PROCESS | 1969 | 14:38:36 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-fft) 14:38:37 INFO - PROCESS | 1969 | RSS: Main: 192102400 14:38:37 INFO - PROCESS | 1969 | 14:38:39 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50276/tests/kraken/driver.html?testName=audio-oscillator) 14:38:40 INFO - PROCESS | 1969 | RSS: Main: 192638976 14:38:40 INFO - PROCESS | 1969 | 14:38:42 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:42 INFO - PROCESS | 1969 | RSS: Main: 194097152 14:38:42 INFO - PROCESS | 1969 | 14:38:45 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:46 INFO - PROCESS | 1969 | RSS: Main: 194359296 14:38:46 INFO - PROCESS | 1969 | 14:38:48 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50276/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:49 INFO - PROCESS | 1969 | RSS: Main: 194228224 14:38:49 INFO - PROCESS | 1969 | 14:38:52 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50276/tests/kraken/driver.html?testName=json-parse-financial) 14:38:52 INFO - PROCESS | 1969 | RSS: Main: 194301952 14:38:52 INFO - PROCESS | 1969 | 14:38:54 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:55 INFO - PROCESS | 1969 | RSS: Main: 193990656 14:38:55 INFO - PROCESS | 1969 | 14:38:56 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:57 INFO - PROCESS | 1969 | RSS: Main: 194052096 14:38:57 INFO - PROCESS | 1969 | 14:38:59 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:39:00 INFO - PROCESS | 1969 | RSS: Main: 194285568 14:39:00 INFO - PROCESS | 1969 | 14:39:02 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:39:03 INFO - PROCESS | 1969 | RSS: Main: 194478080 14:39:03 INFO - PROCESS | 1969 | 14:39:05 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:39:06 INFO - PROCESS | 1969 | RSS: Main: 194555904 14:39:06 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:50276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50276/tests/kraken/driver.html?testName=ai-astar) 14:39:08 INFO - PROCESS | 1969 | RSS: Main: 196292608 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | __start_tp_report 14:39:08 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 14:39:08 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 14:39:08 INFO - PROCESS | 1969 | |i|pagename|runs| 14:39:08 INFO - PROCESS | 1969 | |0;ai-astar;115;109;115;114;115;129;115;115;115;113 14:39:08 INFO - PROCESS | 1969 | |1;audio-beat-detection;148;123;156;146;121;142;139;119;157;121 14:39:08 INFO - PROCESS | 1969 | |2;audio-dft;269;262;196;194;194;227;222;194;222;224 14:39:08 INFO - PROCESS | 1969 | |3;audio-fft;73;92;100;104;82;83;83;91;130;56 14:39:08 INFO - PROCESS | 1969 | |4;audio-oscillator;86;80;125;79;83;80;119;77;80;121 14:39:08 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;89;87;88;86;88;86;89;86;88;85 14:39:08 INFO - PROCESS | 1969 | |6;imaging-darkroom;95;96;96;94;109;138;96;95;95;95 14:39:08 INFO - PROCESS | 1969 | |7;imaging-desaturate;103;96;92;90;92;90;90;100;92;100 14:39:08 INFO - PROCESS | 1969 | |8;json-parse-financial;56;61;58;59;59;60;57;70;59;70 14:39:08 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;64;62;71;67;69;74;69;66;66;64 14:39:08 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;84;81;83;82;83;81;80;84;83;86 14:39:08 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;120;132;132;122;115;125;132;132;133;123 14:39:08 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;135;137;139;133;137;135;136;135;136;159 14:39:08 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;63;90;92;90;68;67;64;67;64;64 14:39:08 INFO - PROCESS | 1969 | __end_tp_report 14:39:08 INFO - PROCESS | 1969 | __start_cc_report 14:39:08 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,891 14:39:08 INFO - PROCESS | 1969 | __end_cc_report 14:39:08 INFO - PROCESS | 1969 | __startTimestamp1461620348310__endTimestamp 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | ------- Summary: start ------- 14:39:08 INFO - PROCESS | 1969 | Number of tests: 14 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:5.10 (4.4%) stddev-sans-first:5.41 14:39:08 INFO - PROCESS | 1969 | Values: 115.0 109.0 115.0 114.0 115.0 129.0 115.0 115.0 115.0 113.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:144.00 stddev:14.99 (10.4%) stddev-sans-first:15.39 14:39:08 INFO - PROCESS | 1969 | Values: 148.0 123.0 156.0 146.0 121.0 142.0 139.0 119.0 157.0 121.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:220.40 Median:223.00 stddev:27.57 (12.4%) stddev-sans-first:22.96 14:39:08 INFO - PROCESS | 1969 | Values: 269.0 262.0 196.0 194.0 194.0 227.0 222.0 194.0 222.0 224.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:89.40 Median:82.50 stddev:19.73 (23.9%) stddev-sans-first:20.02 14:39:08 INFO - PROCESS | 1969 | Values: 73.0 92.0 100.0 104.0 82.0 83.0 83.0 91.0 130.0 56.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:80.00 stddev:19.98 (25.0%) stddev-sans-first:21.03 14:39:08 INFO - PROCESS | 1969 | Values: 86.0 80.0 125.0 79.0 83.0 80.0 119.0 77.0 80.0 121.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 14:39:08 INFO - PROCESS | 1969 | Values: 89.0 87.0 88.0 86.0 88.0 86.0 89.0 86.0 88.0 85.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:95.00 stddev:13.75 (14.5%) stddev-sans-first:14.41 14:39:08 INFO - PROCESS | 1969 | Values: 95.0 96.0 96.0 94.0 109.0 138.0 96.0 95.0 95.0 95.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:91.00 stddev:4.88 (5.4%) stddev-sans-first:4.10 14:39:08 INFO - PROCESS | 1969 | Values: 103.0 96.0 92.0 90.0 92.0 90.0 90.0 100.0 92.0 100.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:59.50 stddev:5.00 (8.4%) stddev-sans-first:4.98 14:39:08 INFO - PROCESS | 1969 | Values: 56.0 61.0 58.0 59.0 59.0 60.0 57.0 70.0 59.0 70.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:68.00 stddev:3.61 (5.3%) stddev-sans-first:3.64 14:39:08 INFO - PROCESS | 1969 | Values: 64.0 62.0 71.0 67.0 69.0 74.0 69.0 66.0 66.0 64.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.77 (2.1%) stddev-sans-first:1.81 14:39:08 INFO - PROCESS | 1969 | Values: 84.0 81.0 83.0 82.0 83.0 81.0 80.0 84.0 83.0 86.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:132.00 stddev:6.43 (4.9%) stddev-sans-first:6.36 14:39:08 INFO - PROCESS | 1969 | Values: 120.0 132.0 132.0 122.0 115.0 125.0 132.0 132.0 133.0 123.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.20 Median:136.50 stddev:7.48 (5.5%) stddev-sans-first:7.84 14:39:08 INFO - PROCESS | 1969 | Values: 135.0 137.0 139.0 133.0 137.0 135.0 136.0 135.0 136.0 159.0 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:67.50 stddev:12.38 (18.3%) stddev-sans-first:12.60 14:39:08 INFO - PROCESS | 1969 | Values: 63.0 90.0 92.0 90.0 68.0 67.0 64.0 67.0 64.0 64.0 14:39:08 INFO - PROCESS | 1969 | -------- Summary: end -------- 14:39:08 INFO - PROCESS | 1969 | 14:39:08 INFO - TEST-INFO | 1969: exit 0 14:39:09 INFO - TEST-OK | kraken | took 57118ms 14:39:09 INFO - SUITE-END | took 1166s 14:39:09 INFO - Completed test suite (00:19:26) 14:39:09 INFO - javascript benchmark 14:39:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2926.487864623691, 3656.1773600939773, 3681.374166391713, 3683.723720720945, 3706.8887933361993, 5841.744025034617, 5927.73325200366, 5936.673482958447, 5965.403459654032, 6011.428914253144, 4917.950820491803, 5970.373110823366, 6022.976094064009, 6023.096535519674, 6036.939630603692, 5243.292155559008, 5314.707691076989, 5413.566914646819, 5429.567601394627, 5468.152436372348, 5285.550728188108, 5334.306540149775, 5364.973175134119, 5421.756020979065, 5448.128299472085, 4844.66087373884, 5061.329761178802, 5406.405295417501, 5423.918641220384, 5464.726763661821, 4357.6078152966065, 5336.039512887717, 5392.218128371364, 5463.672179669213, 5483.561315094783, 4331.761753103609, 5174.508421699932, 5266.4733526647415, 5277.419483856773, 5298.231756395339, 5692.544596432275, 5743.942560574383, 5749.741261643236, 5757.798477053283, 5836.6789826559525, 6127.34224287047, 6175.228096487939, 6230.937690623081, 6245.656488893109, 6251.12484252205, 6238.9376106238815, 6308.3060863305, 6315.778947736807, 6325.5255855811, 6336.80989570309, 6050.848728781772, 6067.029275315972, 6072.666003369813, 6105.175801266772, 6109.6639684817765, 6261.060840873905, 6357.205349331333, 6390.840228994312, 6398.8720225595225, 6489.0, 6176.320604733476, 6193.81418557444, 6195.380461953769, 6223.1287619733275, 6230.06549017651, 6315.684215789192, 6319.9368006320265, 6334.746610135635, 6341.619502829845, 6348.936510634927, 6118.174046503754, 6144.433169541828, 6146.4775494082605, 6172.598781079216, 6216.316205217422, 6179.227596550431, 6189.35011823761, 6197.566170368031, 6212.782552610637, 6242.875142497215, 4979.502049794992, 4985.4017517897355, 4986.177280748709, 4993.151164302078, 4996.650234483552, 4349.739015659071, 4452.910941781146, 4471.150481408522, 4541.545845415432, 4599.264117741145, 5365.9731701342025, 5785.582532279618, 5978.611390259619, 6008.0, 6066.3023752269055, 6229.221347331583, 6251.718672659741, 6267.561270711098, 6272.153259310026, 6286.717097730613, 5944.821655350346, 5995.580309378389, 6030.879382412327, 6037.09443583466, 6076.422739839708, 5491.560675145979, 5537.418571050062, 5552.833414997556, 5558.055130627803, 5560.555155587544, 6385.169927909342, 6546.967265163644, 6551.672416379257, 6574.276829548746, 6589.24223714279, 6218.968905155626, 6274.466670333073, 6312.6528040956355, 6315.052742088724, 6331.841703957438, 6451.548391612542, 6452.161219041494, 6459.644719540471, 6476.222853257639, 6491.350864913471, 6109.175261339662, 6123.892747182756, 6154.78458253959, 6189.6286222826775, 6197.5351848610635, 6209.441150296495, 6217.222847144107, 6261.530385221035, 6266.342034086355, 6301.684915754286, 6145.569810113249, 6153.292371377349, 6160.075988601746, 6176.1970943778815, 6180.351063138306, 4982.0, 6140.723667435065, 6153.907691384543, 6166.105914642441, 6203.503719702323, 5851.94148058531, 6148.292946311231, 6153.569250152446, 6173.907391389043, 6202.100695399052, 5144.0, 6214.378562143749, 6228.5951413158, 6243.7814676486105, 6261.3112557617715, 6110.236220472441, 6112.07291107, 6130.325664177026, 6242.1261023455845, 6268.341824108586], "unit": "score", "name": "dojo.html", "value": 5789.433595051605}, {"lowerIsBetter": false, "replicates": [539.8164624027833, 603.4599033864691, 611.825295432769, 619.6746707978308, 687.8375545328395, 32740.0, 40295.59704402955, 40707.18585628289, 40754.79622601883, 40918.795406023004, 35827.10432239189, 42153.57846421535, 42215.0, 42259.78870105645, 42760.0, 9723.12491875731, 9854.556544955494, 9928.255380846429, 9936.900630993707, 9943.502824858764, 9641.035896410373, 10084.243681723863, 10120.797584048314, 10133.290669653128, 10180.23648226386, 9685.903140968605, 10087.697369078902, 10158.085772280494, 10160.59357625694, 10174.0, 9796.363236389647, 10054.0, 10126.645567405105, 10130.138938190263, 10161.288709790319, 9930.354526955725, 9969.70090897267, 9995.00049995002, 10015.248856335804, 10046.89953100467, 36919.0, 41880.79059604713, 42320.0, 42395.152096957885, 42763.57236427627, 3162.7311678507353, 3371.2414706691043, 3385.5937287525653, 3444.896653100411, 3484.6689564491335, 28964.71035289641, 29216.0, 29356.00097946603, 29839.552406713916, 30357.544636830466, 2547.4777670577487, 2837.1914004508617, 2840.2757296889163, 2879.8992035278666, 2937.9559306610417, 326607.0, 329516.0, 329841.9999999976, 329998.0, 331159.0, 73006.63496682483, 73204.63397682978, 73759.63120184472, 73811.0, 73942.0, 79422.0, 82438.58780706058, 82481.58759206286, 82642.58678706568, 82847.5857620708, 18290.0, 18290.268389264547, 18625.627487450176, 18704.906475467535, 18867.245310187438, 14008.229547374993, 14066.507672231628, 14111.576652700436, 14206.857931420553, 14248.501302454364, 23512.177073802675, 23798.76201238, 23839.284821455385, 23899.0, 24298.0, 7863.410244231705, 9182.816343673088, 9368.657835541115, 9376.59351097341, 9381.061893810564, 983.8179936711731, 1033.503918119307, 1033.6872172341084, 1058.402002868377, 1066.0512144191675, 31470.213244669067, 31698.049058528282, 31743.76940442426, 31818.04545863628, 32092.518612220836, 1170.6722117807028, 1173.4250217393587, 1177.711460692136, 1206.1677442564603, 1228.9385530723428, 15805.920970395304, 15916.840831591768, 16361.0, 16441.753373699405, 17225.7416138758, 696586.0, 701017.0, 705597.0, 707815.0, 710093.0, 68923.65538172377, 68969.65515172492, 69000.6549967247, 69277.0, 69304.65347673229, 1535.1710076558534, 1552.9378824846879, 1566.8511491408299, 1569.5997520632166, 1688.0125126800713, 32869.0, 32882.34235315232, 32882.34235315232, 32910.17724556905, 33565.32869342648, 57142.142867857845, 57800.71099644475, 57812.4218757807, 57944.42055579559, 58023.0, 531980.0, 534542.0, 536617.0, 536645.0, 537485.0, 34394.65605344014, 35109.82445087758, 48054.27918581154, 49074.0, 50282.24576631426, 47471.0, 48175.277370840166, 48509.27236091532, 49042.0, 49240.261396079804, 40010.79994600009, 40692.79653601713, 40751.77744667665, 40759.0, 41862.74411767652, 39253.607463926135, 40473.0, 40626.18747624972, 40697.186056278115, 40787.18425631411, 38495.0, 40806.77579672614, 41420.0, 42234.73295801131, 42269.36595951002, 26653.600195997464, 31361.05916822499, 31780.841095794374, 34181.829090854386, 34402.65597343994, 21347.893260533598, 24950.62574061354, 25795.742042579335, 25955.351116222246, 26418.73581264163], "unit": "score", "name": "ext.html", "value": 21350.601919361627}, {"lowerIsBetter": false, "replicates": [342.31366110947556, 373.47526724951433, 377.9603141670125, 387.15406836063204, 387.6298135280807, 20535.48661283467, 21151.788482115193, 21578.676319855174, 22110.447238819037, 22255.777442225593, 22300.88849555754, 22822.65766013511, 22852.428689282777, 22864.314070577868, 23266.18568350104, 5861.296644402656, 5869.8826023479505, 6081.604695694788, 6156.722947467352, 6160.599561028541, 5942.0, 5946.43508866657, 5956.612820166697, 6085.300190478085, 6090.14737936687, 5334.706591137486, 5630.887382252373, 5991.191189189447, 6004.12940123684, 6049.213602231704, 5083.593312535007, 5860.648361098327, 5860.648361098348, 5971.98476259037, 6009.519238460913, 1581.0592697345062, 3780.5822816443833, 5169.121249387613, 5198.532132108091, 5233.267342572043, 22595.322140335815, 26250.474990500275, 27057.64711764404, 27262.182134535997, 27453.0, 2137.444264491228, 2483.7143728471096, 2617.1886715118376, 2686.7313268672974, 2721.182744057326, 14090.577282681536, 14900.956933014693, 15523.922380388025, 15599.986000910018, 15602.765958510632, 1803.3507937142617, 1836.412348048625, 1848.9722654160198, 1864.6363959027994, 1893.6307420053095, 103219.0, 103740.48129759303, 105137.94862051358, 106327.0, 106650.46674766653, 10908.672739817817, 11150.275232109887, 11156.497957591928, 11193.552257909756, 11213.271137376045, 11675.12436567261, 13612.387442565108, 13658.0, 13661.931690341484, 13705.383257753425, 9095.31785116119, 9136.81726365469, 9140.040295768982, 9156.542172891328, 9242.76893077665, 9393.013733558015, 9443.669471568463, 9499.38254013487, 9556.856647150298, 9623.230141588656, 5473.151661492475, 6419.839504012437, 6427.967860160763, 6493.902591461132, 6511.218653761579, 1719.664665390262, 1820.3537744100918, 1913.0912816412372, 1920.2511020701659, 1921.9519512012032, 999.3703966501204, 1035.6323505155713, 1066.2152329190185, 1102.1568500097433, 1142.662914440242, 17425.0, 22869.428264293525, 23044.65433018506, 23069.423264418525, 23150.884245578665, 1026.8665073540542, 1056.7358160459885, 1114.8272017837248, 1126.813980877096, 1173.4602083041896, 11654.76690466186, 12105.33420661872, 12109.273443593413, 12124.030077593772, 12184.695382615506, 695104.0, 697134.0, 705901.0, 713121.0, 718149.0, 96038.0, 100121.28593033302, 127237.0, 128385.0, 138688.0, 1043.7599352148895, 1070.7376692710336, 1077.21363404715, 1079.2013909706761, 1085.0885256384674, 19038.048097595343, 19489.41531753993, 19675.31136410219, 19765.703514447006, 19966.401007969784, 54668.633284168216, 55367.0, 56307.436925630216, 57588.71205643945, 57695.42304576901, 78112.09439528115, 78424.8236276445, 83199.5840020796, 83294.0, 84357.57821210855, 8277.461964972257, 8327.833443331221, 8337.916620833714, 8415.705450309455, 8418.831623367621, 9632.629447497842, 13678.974076944469, 13780.353752373177, 13829.792553111913, 14170.92914535462, 11648.242864213798, 11962.401879905796, 12027.579034733742, 12126.908578227649, 12162.209456385306, 10311.690649280534, 11564.479598417924, 11748.58879939198, 11897.40512974365, 12013.45939432745, 11319.377434241196, 12054.15620906528, 12174.39128043612, 12217.633470995885, 12299.139060265696, 8211.95894020526, 8223.383246256675, 8355.95822020886, 8358.749237522885, 8534.615942282737, 10495.317804342692, 11712.414379280832, 11887.811218878043, 11974.341411222467, 12098.213616114925], "unit": "score", "name": "jquery.html", "value": 10046.728052002387}, {"lowerIsBetter": false, "replicates": [1532.3870451819275, 1573.921303934803, 1746.2491128814604, 1773.5920738230216, 2019.7879222681618, 7454.440916931225, 8369.0, 8934.240589549896, 9022.729318120451, 9029.954850225748, 8983.820323593523, 9018.233450156727, 9018.458892466457, 9129.68046118386, 9140.908590914089, 2185.486410693494, 2578.9999999999955, 2609.621604867293, 2610.412657152135, 2614.6600941877623, 2552.808539359546, 2584.2247325802277, 2593.9740602594015, 2595.1436026111337, 2626.2909014566058, 2572.87135643218, 2588.430545280045, 2593.8314009589412, 2597.844129352245, 2603.830751001188, 2586.5473542130144, 2589.184406911817, 2611.621314909337, 2620.489004644095, 2621.25294291128, 2194.3526659635445, 2567.1785028790796, 2596.81822272441, 2610.3213164577155, 2613.2160351894354, 9167.358284920057, 9180.954095229548, 9192.17270445663, 9252.953735231347, 9258.398204116778, 5654.717264136818, 5824.592278540504, 5847.590668653196, 5859.912101318484, 5867.882642347172, 3681.668649821502, 3793.4499497572697, 3833.9456649421354, 3840.8847734568008, 3863.768173909574, 1073.1146803886747, 1091.7761858818924, 1093.4860615510697, 1129.610284451871, 1132.5469812075153, 12347.506099756, 12387.69030774238, 12404.379781010914, 12426.068044896669, 12467.563635272812, 5091.8981620367385, 5109.182530795055, 5164.767585458663, 5173.948260517422, 5189.117849965515, 10635.574577016987, 10681.946590266998, 10716.78566428667, 10792.676219713421, 10929.672109836718, 5817.592768506164, 5832.066869300977, 5850.297964244318, 5878.882422351529, 5889.94110058894, 4736.95263047372, 5120.334356533627, 5206.453322401169, 5215.739213039333, 5310.017646735367, 4128.70074388312, 4129.318662420667, 4145.150244199932, 4165.437665915123, 4179.791010449465, 1378.3521744779937, 1391.3599744117616, 1398.7482253194523, 1401.1803095189225, 1405.6345350208815, 1401.9579412617638, 1446.197360464931, 1448.3844366144347, 1451.3178805961181, 1457.154850186889, 8631.741047768577, 8643.956780216184, 8682.348823838238, 8686.739397818075, 8687.478751274944, 535.3923297057868, 545.1414022913926, 545.3510322715955, 546.8277492589901, 552.7236381809096, 5429.4299098594865, 6341.207349081365, 6355.0, 6364.981602943507, 6402.743890244338, 10989.450527473755, 11304.830427543593, 11383.601573944872, 11417.42912854354, 11511.366874821797, 10906.236563440641, 11185.832212516818, 11243.156763242627, 11253.437328133561, 11350.0, 8741.562921853882, 8789.560521973875, 8808.163224493663, 8819.867701984474, 8847.955760221157, 8147.10381858007, 8178.304844088319, 8206.22040906113, 8293.880326155891, 8322.833543328978, 9676.12914837668, 9803.0, 9812.067853553901, 10075.949620252146, 10203.642872499428, 9968.451735154345, 10105.44420056904, 10155.238357123097, 10229.130523905551, 10239.334443261165, 5579.944200558105, 7571.280728330799, 7591.62041897914, 7641.617919104134, 7642.235776422535, 8414.410991230556, 8520.659173632985, 8533.232009119209, 8567.785805354915, 8628.827423451621, 7583.203763604963, 7763.417743669134, 7768.53388796674, 7813.1405545388825, 7851.921480785348, 7636.198199189227, 7728.729494467667, 7729.149793522595, 7836.37309015266, 7863.646135923783, 6973.755918542826, 8155.347572194091, 8162.510249385056, 8275.255227029596, 8289.295409889986, 7359.337659610661, 7409.888851667121, 7420.6660700269695, 7423.888641670487, 7424.888626670712, 7448.068991376078, 7514.0, 7526.0, 7546.9245307546225, 7567.621618918922], "unit": "score", "name": "mootools.html", "value": 5078.190159949298}, {"lowerIsBetter": false, "replicates": [342.209496064092, 346.36960731468736, 347.18758106031896, 349.0505824158292, 352.78832700379775, 6014.969925150368, 6914.688839002244, 7015.193252775926, 7024.824379390518, 7070.823229419267, 5988.850278743033, 6767.661616919159, 6898.413634841045, 6943.201531823842, 6984.755533556327, 4922.630802689795, 5002.799888004475, 5098.770555325001, 5099.821506247282, 5194.37667479902, 5065.493450654942, 5085.923711144335, 5097.592192624581, 5103.8468845934685, 5121.308623335839, 5004.549590536851, 5019.924701129486, 5026.120428924942, 5039.344885164942, 5055.216441451581, 5017.824376146836, 5049.166887463564, 5072.137736584789, 5166.664166829181, 5178.249153872667, 4456.420665313521, 4461.639200044017, 4467.910641787179, 4470.709403888737, 4471.597556219956, 5061.949380506221, 6358.968205158991, 6682.665866706694, 6696.5647232929705, 6728.428083612899, 5873.911891321633, 5908.704564771744, 5937.376575459601, 5946.43508866657, 5951.851203719898, 5947.434993675594, 7414.962925185394, 7416.480846340758, 7417.777466676009, 7425.777226683208, 3929.332013557702, 3979.8607048753156, 4758.119747846659, 4797.64017698674, 4808.591269742076, 7722.806929826743, 7814.960925195338, 7821.687132514692, 7860.292573668397, 7876.094249161362, 4603.079384123122, 4675.696079754873, 4841.927371089437, 4899.975500122548, 4908.165611845995, 4036.878893633137, 4461.843835465743, 4965.081459929852, 4982.451930287665, 4985.476524964899, 4665.4168228971375, 5897.705114744245, 5965.164876917235, 5984.0, 5984.700764961822, 6968.512204145661, 7495.0, 7500.924990750132, 7507.474476786681, 7522.0, 1511.4332125452954, 1725.7583938248656, 1726.9050202238745, 1727.136431784108, 1731.7921849378156, 1056.144522936424, 1094.6168840905777, 1095.1020163465882, 1103.5144536404116, 1118.1557923767666, 6955.095837541087, 7011.474139439562, 7014.088168538159, 7016.5790052597, 7033.753818616324, 7432.516886402366, 7588.0, 7597.886031709529, 7619.161892191854, 7643.847123057508, 6870.0, 7152.105986751656, 7155.3202445767565, 7161.9641901790155, 7162.818135007666, 4031.8992025199605, 4088.6729061674996, 4089.3048181809163, 4092.9795351023054, 4111.362738775495, 6497.415232628991, 8078.676852925817, 8081.919180808234, 8085.312748416332, 8087.797805054803, 7829.725959591501, 7966.402519811038, 8015.839683206304, 8019.03771547418, 8116.553589552514, 8163.836723265502, 8170.264676179172, 8184.427090103635, 8217.79455513617, 8236.958815206006, 7773.989381380385, 7792.84414311722, 7823.335016523659, 7831.021122359705, 7845.3723702104835, 6379.93620063812, 7539.623018848926, 7668.309852113337, 7672.079350477979, 7672.578008209602, 7803.609819508888, 8135.30849877767, 8154.14381489935, 8164.1019487857475, 8224.218699223564, 4838.491958344464, 4855.295982082507, 4901.019796040735, 4904.754762261944, 4906.681065730716, 7748.922510775045, 7757.612119393895, 7758.92241077582, 7764.61176941162, 7773.222677732408, 7425.368843648351, 7445.851082978418, 7449.174952136761, 7454.850902982019, 7464.402847772274, 7039.577625342496, 7373.55758654461, 7402.629868506446, 7422.777316680508, 7460.477766556289, 5915.763369465345, 7181.922711593303, 7274.127104747253, 7275.963620181865, 7281.235470275545, 7410.296021877913, 7411.221821708858, 7424.703011879465, 7445.181030086795, 7447.180810110775, 6995.125609298838, 7284.996625927913, 7295.306945840137, 7298.124225093023, 7363.521371110861], "unit": "score", "name": "prototype.html", "value": 5389.342642486255}, {"lowerIsBetter": false, "replicates": [696.4219697650949, 713.4078714666826, 714.2571725405581, 745.0649434959125, 817.3665409307786, 15454.0, 15458.07251564907, 15467.690646187084, 15560.45538406156, 15577.376904923789, 14511.927440362784, 14554.27228638569, 14606.634834129152, 14629.853701462982, 14662.0, 794.7774623105539, 964.3731574476611, 969.3069455339431, 978.9216862651007, 1000.7998400319929, 978.66236148529, 981.1562056631292, 981.5681100315874, 988.2094324540375, 1005.0251256281396, 877.8156587116713, 916.9816603667923, 1022.5735099536142, 1042.4527123260273, 1060.0, 1017.1862509992051, 1031.6234574380371, 1034.4052170002278, 1037.8598889149944, 1057.0961827637336, 657.5824351536761, 778.2334400615389, 788.6687591211705, 790.5019837502394, 792.9444938854283, 15302.311395987095, 15818.525444236691, 15851.682966340724, 15891.205439727968, 15915.761263581055, 13306.86693133066, 13327.866721332759, 13330.666733331647, 13370.465181392732, 13414.597562073153, 8499.235068843773, 10296.79406411875, 10401.531931063044, 10427.530761115768, 10513.369197848077, 3582.7133829293593, 3635.909102272464, 3646.2707458508403, 3699.3341198584244, 3862.787546684959, 77389.0, 80350.0, 81294.0, 81430.59284703598, 81703.18296817015, 9810.313278070467, 9917.355371900803, 10080.29437939352, 10081.798364032826, 10284.331518451278, 22606.0, 22933.655995160087, 23077.19229826948, 23082.422939426313, 24406.65763383031, 6846.7945961621235, 7894.250046245597, 8098.635561399751, 8151.225633564802, 8153.1439198884445, 4209.810558524874, 4235.216484950294, 4260.978695106566, 4343.326784348431, 4374.321980093091, 3791.905202369963, 3823.7132215083425, 3827.234553089393, 3847.8076096195637, 3902.746321489094, 614.695725615823, 668.4451904918906, 678.772611175252, 680.452235950065, 682.2461180395691, 553.2227220754846, 576.9134629805562, 619.0868469008177, 620.6586377492362, 640.4652115483531, 7475.6708203684975, 8132.390070744717, 8157.021157461024, 8582.742517724479, 8599.312055035582, 590.2945979554391, 617.237711426388, 618.5793660311032, 619.6437048697018, 627.0688028278004, 3914.354131568259, 3984.561698213194, 4047.866597352746, 4061.2283666103344, 4224.070704445017, 78305.0, 97918.51040744751, 98168.50915745518, 98720.0, 99584.50623240657, 62355.505779769206, 77212.61393692995, 77820.83268750973, 84379.5781021091, 85185.57407212924, 74914.25085749073, 75173.0, 75533.0, 81998.59000704958, 83295.0, 7305.963470182615, 8761.561921904007, 8960.68637597681, 9055.81888362216, 9104.499252541174, 51152.74423627858, 51191.72020699512, 52750.73624631852, 53037.0, 56400.614769388245, 66322.66838665969, 71745.64127179331, 72638.63680681563, 73497.42759003409, 74328.62835685787, 11539.653810385702, 11656.650300491, 11843.348615826213, 11897.583584574499, 11987.100967427652, 12175.33035683046, 12184.0, 12288.139830212156, 12388.946939509882, 12653.74692506163, 11960.58137965167, 11980.460879260629, 12005.459754310903, 12247.632571022883, 12342.321172335607, 11869.0, 12000.459979300778, 12018.278903265833, 12112.45493952792, 12138.635840924786, 10750.247482676137, 11087.390193539433, 11496.82754758696, 11715.882841171479, 11940.641780746591, 9666.371685840399, 9891.406515609087, 10125.797484050425, 10153.543090560795, 10209.9489502552, 8783.692570760248, 9743.392340264061, 9896.703098907044, 10040.397576145455, 10081.899181008095], "unit": "score", "name": "yui.html", "value": 7222.115094919522}], "name": "dromaeo_css", "value": 7912.904410664984}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 114.0, 115.0, 129.0, 115.0, 115.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 156.0, 146.0, 121.0, 142.0, 139.0, 119.0, 157.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 137.2}, {"lowerIsBetter": true, "replicates": [269.0, 262.0, 196.0, 194.0, 194.0, 227.0, 222.0, 194.0, 222.0, 224.0], "unit": "score", "name": "audio-dft", "value": 220.4}, {"lowerIsBetter": true, "replicates": [73.0, 92.0, 100.0, 104.0, 82.0, 83.0, 83.0, 91.0, 130.0, 56.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [86.0, 80.0, 125.0, 79.0, 83.0, 80.0, 119.0, 77.0, 80.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 88.0, 86.0, 88.0, 86.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 94.0, 109.0, 138.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 100.9}, {"lowerIsBetter": true, "replicates": [103.0, 96.0, 92.0, 90.0, 92.0, 90.0, 90.0, 100.0, 92.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 94.5}, {"lowerIsBetter": true, "replicates": [56.0, 61.0, 58.0, 59.0, 59.0, 60.0, 57.0, 70.0, 59.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 71.0, 67.0, 69.0, 74.0, 69.0, 66.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 82.0, 83.0, 81.0, 80.0, 84.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [120.0, 132.0, 132.0, 122.0, 115.0, 125.0, 132.0, 132.0, 133.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [135.0, 137.0, 139.0, 133.0, 137.0, 135.0, 136.0, 135.0, 136.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.2}, {"lowerIsBetter": true, "replicates": [63.0, 90.0, 92.0, 90.0, 68.0, 67.0, 64.0, 67.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.9}], "name": "kraken", "value": 1486.6000000000001}]} 14:39:09 INFO - Return code: 0 14:39:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:39:09 ERROR - # TBPL SUCCESS # 14:39:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:09 INFO - 2016-04-25 14:39:09.664 screenresolution[1974:13293] starting screenresolution argv=screenresolution get 14:39:09 INFO - 2016-04-25 14:39:09.666 screenresolution[1974:13293] Display 0: 1600x1200x32@60 14:39:09 INFO - 2016-04-25 14:39:09.672 screenresolution[1975:13296] starting screenresolution argv=screenresolution list 14:39:09 INFO - Available Modes on Display 0 14:39:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:09 INFO - Intel Iris: 14:39:09 INFO - Chipset Model: Intel Iris 14:39:09 INFO - Type: GPU 14:39:09 INFO - Bus: Built-In 14:39:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:09 INFO - Vendor: Intel (0x8086) 14:39:09 INFO - Device ID: 0x0a2e 14:39:09 INFO - Revision ID: 0x0009 14:39:09 INFO - Displays: 14:39:09 INFO - Display: 14:39:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:09 INFO - Display Serial Number: 1600x1200 60 14:39:09 INFO - Main Display: Yes 14:39:09 INFO - Mirror: Off 14:39:09 INFO - Online: Yes 14:39:09 INFO - Rotation: Supported 14:39:09 INFO - Return code: 0 14:39:09 INFO - Running post-action listener: _resource_record_post_action 14:39:09 INFO - Running post-run listener: _resource_record_post_run 14:39:10 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 946176; Write bytes: 511508480; Read time: 14; Write time: 2168 14:39:10 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197280256; Write bytes: 199075328; Read time: 18113; Write time: 445 14:39:10 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 946176; Write bytes: 302475776; Read time: 14; Write time: 1686 14:39:10 INFO - Running post-run listener: _upload_blobber_files 14:39:10 INFO - Blob upload gear active. 14:39:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:39:10 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 14:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:39:11 INFO - (blobuploader) - INFO - Open directory for files ... 14:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:12 INFO - (blobuploader) - INFO - Done attempting. 14:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:39:13 INFO - (blobuploader) - INFO - Done attempting. 14:39:13 INFO - (blobuploader) - INFO - Iteration through files over. 14:39:13 INFO - Return code: 0 14:39:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:39:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:39:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a59a7c19261101f37aa1092b05b0c935d243387dc2ff2d0df0ee8dcaed8428a0311749aee478c0fcbd6251d5b8bfae2d2246afaeccac4b2974955cf0d3c53bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4942f98fe1aa9703902ca4fee300b1ba3bd94a4242968ac023de3a46c862155724f351ab4027f77363a3e132709bda443cdcb22827e5ea46d78d5af4e4a194"} 14:39:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:39:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:39:13 INFO - Contents: 14:39:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a59a7c19261101f37aa1092b05b0c935d243387dc2ff2d0df0ee8dcaed8428a0311749aee478c0fcbd6251d5b8bfae2d2246afaeccac4b2974955cf0d3c53bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4942f98fe1aa9703902ca4fee300b1ba3bd94a4242968ac023de3a46c862155724f351ab4027f77363a3e132709bda443cdcb22827e5ea46d78d5af4e4a194"} 14:39:13 INFO - Running post-run listener: copy_logs_to_upload_dir 14:39:13 INFO - Copying logs to upload dir... 14:39:13 INFO - mkdir: /builds/slave/test/build/upload/logs 14:39:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.300256 ========= master_lag: 3.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-25 14:39:17.185181) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:17.189567) ========= 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.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a59a7c19261101f37aa1092b05b0c935d243387dc2ff2d0df0ee8dcaed8428a0311749aee478c0fcbd6251d5b8bfae2d2246afaeccac4b2974955cf0d3c53bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4942f98fe1aa9703902ca4fee300b1ba3bd94a4242968ac023de3a46c862155724f351ab4027f77363a3e132709bda443cdcb22827e5ea46d78d5af4e4a194"} build_url:https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010961 build_url: 'https://queue.taskcluster.net/v1/task/Ldkw5WppQsCyV7f_wMcgGg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a59a7c19261101f37aa1092b05b0c935d243387dc2ff2d0df0ee8dcaed8428a0311749aee478c0fcbd6251d5b8bfae2d2246afaeccac4b2974955cf0d3c53bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4942f98fe1aa9703902ca4fee300b1ba3bd94a4242968ac023de3a46c862155724f351ab4027f77363a3e132709bda443cdcb22827e5ea46d78d5af4e4a194"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:17.544913) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:17.545298) ========= 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.mOJhrV94pF/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.RyArTGmLx9/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005024 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:39:17.589247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:17.589627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:39:17.595557) ========= ========= Total master_lag: 4.44 =========