builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1467973272.03 results: success (0) buildid: 20160708021326 builduid: 42396063891c4889bb337833f7f3e65f revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.025943) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.027066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.027346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.071175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.071519) ========= 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.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-08 03:21:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-07-08 03:21:12 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.614173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.708524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.708825) ========= 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.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.020023 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.757779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:12.758092) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75b9cc8259df0aca3d93c4b44155a77875341a14 --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 75b9cc8259df0aca3d93c4b44155a77875341a14 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-08 03:21:12,831 truncating revision to first 12 chars 2016-07-08 03:21:12,831 Setting DEBUG logging. 2016-07-08 03:21:12,831 attempt 1/10 2016-07-08 03:21:12,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/75b9cc8259df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 03:21:13,511 unpacking tar archive at: mozilla-beta-75b9cc8259df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.721142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.721409) ========= script_repo_revision: 75b9cc8259df0aca3d93c4b44155a77875341a14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.721787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.722058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 03:21:13.741730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-08 03:21:13.742019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:13 INFO - MultiFileLogger online at 20160708 03:21:13 in /builds/slave/test 03:21:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:21:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:21:13 INFO - {'append_to_log': False, 03:21:13 INFO - 'base_work_dir': '/builds/slave/test', 03:21:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:21:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:21:13 INFO - 'branch': 'Mozilla-Beta', 03:21:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:13 INFO - 'config_files': ('talos/mac_config.py',), 03:21:13 INFO - 'default_actions': ('clobber', 03:21:13 INFO - 'read-buildbot-config', 03:21:13 INFO - 'download-and-extract', 03:21:13 INFO - 'populate-webroot', 03:21:13 INFO - 'create-virtualenv', 03:21:13 INFO - 'install', 03:21:13 INFO - 'run-tests'), 03:21:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:13 INFO - 'download_minidump_stackwalk': True, 03:21:13 INFO - 'download_symbols': 'ondemand', 03:21:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:13 INFO - 'installer_path': 'installer.exe', 03:21:13 INFO - 'log_level': 'info', 03:21:13 INFO - 'log_name': 'talos', 03:21:13 INFO - 'log_to_console': True, 03:21:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:21:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:21:13 INFO - 'opt_config_files': (), 03:21:13 INFO - 'pip_index': False, 03:21:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:13 INFO - 'cmd': ('bash', 03:21:13 INFO - '-c', 03:21:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:13 INFO - 'enabled': True, 03:21:13 INFO - 'halt_on_failure': False, 03:21:13 INFO - 'name': 'check_screen_resolution'},), 03:21:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:21:13 INFO - 'cmd': ('bash', 03:21:13 INFO - '-c', 03:21:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:21:13 INFO - 'enabled': True, 03:21:13 INFO - 'halt_on_failure': False, 03:21:13 INFO - 'name': 'check_screen_resolution'},), 03:21:13 INFO - 'run_cmd_checks_enabled': True, 03:21:13 INFO - 'sps_profile': False, 03:21:13 INFO - 'sps_profile_interval': 0, 03:21:13 INFO - 'suite': 'dromaeojs', 03:21:13 INFO - 'system_bits': '32', 03:21:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:13 INFO - 'title': 't-yosemite-r7-0100', 03:21:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:13 INFO - 'use_talos_json': True, 03:21:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:21:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:13 INFO - 'work_dir': 'build'} 03:21:13 INFO - ##### 03:21:13 INFO - ##### Running clobber step. 03:21:13 INFO - ##### 03:21:13 INFO - Running pre-action listener: _resource_record_pre_action 03:21:13 INFO - Running main action method: clobber 03:21:13 INFO - rmtree: /builds/slave/test/build 03:21:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running read-buildbot-config step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: read_buildbot_config 03:21:15 INFO - Using buildbot properties: 03:21:15 INFO - { 03:21:15 INFO - "project": "", 03:21:15 INFO - "product": "firefox", 03:21:15 INFO - "script_repo_revision": "production", 03:21:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 03:21:15 INFO - "repository": "", 03:21:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 03:21:15 INFO - "buildid": "20160708021326", 03:21:15 INFO - "pgo_build": "False", 03:21:15 INFO - "basedir": "/builds/slave/test", 03:21:15 INFO - "buildnumber": 29, 03:21:15 INFO - "slavename": "t-yosemite-r7-0100", 03:21:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:21:15 INFO - "platform": "yosemite_r7", 03:21:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:21:15 INFO - "branch": "mozilla-beta", 03:21:15 INFO - "repo_path": "releases/mozilla-beta", 03:21:15 INFO - "revision": "75b9cc8259df0aca3d93c4b44155a77875341a14", 03:21:15 INFO - "stage_platform": "macosx64", 03:21:15 INFO - "builduid": "42396063891c4889bb337833f7f3e65f", 03:21:15 INFO - "slavebuilddir": "test" 03:21:15 INFO - } 03:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running download-and-extract step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: download_and_extract 03:21:15 INFO - mkdir: /builds/slave/test/build/tests 03:21:15 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')]} 03:21:15 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 03:21:17 INFO - Downloaded 1165 bytes. 03:21:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:21:17 INFO - Using the following test package requirements: 03:21:17 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:21:17 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 03:21:17 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 03:21:17 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:21:17 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 03:21:17 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:21:17 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 03:21:17 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 03:21:17 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 03:21:17 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:21:17 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 03:21:17 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 03:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:17 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:21:19 INFO - Downloaded 18351477 bytes. 03:21:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:22 INFO - Return code: 0 03:21:22 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:22 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:21:28 INFO - Downloaded 18351477 bytes. 03:21:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:21:32 INFO - Return code: 0 03:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:32 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 03:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 03:21:33 INFO - Downloaded 10840145 bytes. 03:21:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:21:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:21:33 INFO - Return code: 0 03:21:33 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')]} 03:21:33 INFO - https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 03:21:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 03:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 03:21:36 INFO - Downloaded 86184205 bytes. 03:21:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:36 INFO - mkdir: /builds/slave/test/properties 03:21:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:36 INFO - Contents: 03:21:36 INFO - build_url:https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:21:38 INFO - Running post-action listener: _resource_record_post_action 03:21:38 INFO - Running post-action listener: set_extra_try_arguments 03:21:38 INFO - ##### 03:21:38 INFO - ##### Running populate-webroot step. 03:21:38 INFO - ##### 03:21:38 INFO - Running pre-action listener: _resource_record_pre_action 03:21:38 INFO - Running main action method: populate_webroot 03:21:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:38 INFO - '--tppagecycles', 03:21:38 INFO - '7'], 03:21:38 INFO - 'tests': ['tsvgm']}}, 03:21:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['damp', 'tps']}, 03:21:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'tests': ['damp', 'tps']}, 03:21:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['dromaeo_dom']}, 03:21:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['a11yr', 03:21:38 INFO - 'ts_paint', 03:21:38 INFO - 'tpaint', 03:21:38 INFO - 'sessionrestore', 03:21:38 INFO - 'sessionrestore_no_auto_restore', 03:21:38 INFO - 'tabpaint']}, 03:21:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['tsvgx', 03:21:38 INFO - 'tsvgr_opacity', 03:21:38 INFO - 'tart', 03:21:38 INFO - 'tscrollx', 03:21:38 INFO - 'cart']}, 03:21:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:38 INFO - 'tsvgr_opacity', 03:21:38 INFO - 'tart', 03:21:38 INFO - 'tscrollx', 03:21:38 INFO - 'cart']}, 03:21:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'talos_options': ['--disable-e10s'], 03:21:38 INFO - 'tests': ['tp5o']}, 03:21:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'tests': ['tp5o']}, 03:21:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'talos_options': ['--disable-e10s', 03:21:38 INFO - '--xperf_path', 03:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:38 INFO - 'tests': ['tp5n']}, 03:21:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:38 INFO - 'talos_options': ['--xperf_path', 03:21:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:38 INFO - 'tests': ['tp5n']}}, 03:21:38 INFO - 'talos.zip': {'path': '', 03:21:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:38 INFO - Running post-action listener: _resource_record_post_action 03:21:38 INFO - ##### 03:21:38 INFO - ##### Running create-virtualenv step. 03:21:38 INFO - ##### 03:21:38 INFO - Running pre-action listener: _resource_record_pre_action 03:21:38 INFO - Running main action method: create_virtualenv 03:21:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:38 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 03:21:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:39 INFO - Using real prefix '/tools/python27' 03:21:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:42 INFO - Installing pip.................done. 03:21:42 INFO - Return code: 0 03:21:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:42 INFO - 'HOME': '/Users/cltbld', 03:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:42 INFO - 'LOGNAME': 'cltbld', 03:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:42 INFO - 'MOZ_NO_REMOTE': '1', 03:21:42 INFO - 'NO_EM_RESTART': '1', 03:21:42 INFO - 'PAGER': '/bin/cat', 03:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:42 INFO - 'PWD': '/builds/slave/test', 03:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:42 INFO - 'SHELL': '/bin/bash', 03:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:42 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:42 INFO - 'USER': 'cltbld', 03:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:42 INFO - 'XPC_FLAGS': '0x0', 03:21:42 INFO - 'XPC_SERVICE_NAME': '0', 03:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 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 03:21:43 INFO - Cleaning up... 03:21:43 INFO - Return code: 0 03:21:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:43 INFO - 'HOME': '/Users/cltbld', 03:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PAGER': '/bin/cat', 03:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test', 03:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:43 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - 'XPC_FLAGS': '0x0', 03:21:43 INFO - 'XPC_SERVICE_NAME': '0', 03:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 INFO - Downloading/unpacking psutil>=0.7.1 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:46 INFO - Installing collected packages: psutil 03:21:46 INFO - Running setup.py install for psutil 03:21:46 INFO - building 'psutil._psutil_osx' extension 03:21:46 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 03:21:46 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 03:21:46 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 03:21:46 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 03:21:47 INFO - building 'psutil._psutil_posix' extension 03:21:47 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 03:21:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:47 INFO - ^ 03:21:47 INFO - 1 warning generated. 03:21:47 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 03:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:47 INFO - Successfully installed psutil 03:21:47 INFO - Cleaning up... 03:21:47 INFO - Return code: 0 03:21:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:47 INFO - 'HOME': '/Users/cltbld', 03:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:47 INFO - 'LOGNAME': 'cltbld', 03:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:47 INFO - 'MOZ_NO_REMOTE': '1', 03:21:47 INFO - 'NO_EM_RESTART': '1', 03:21:47 INFO - 'PAGER': '/bin/cat', 03:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:47 INFO - 'PWD': '/builds/slave/test', 03:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:47 INFO - 'SHELL': '/bin/bash', 03:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:47 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:47 INFO - 'USER': 'cltbld', 03:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:47 INFO - 'XPC_FLAGS': '0x0', 03:21:47 INFO - 'XPC_SERVICE_NAME': '0', 03:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:21:50 INFO - Installing collected packages: mozsystemmonitor 03:21:50 INFO - Running setup.py install for mozsystemmonitor 03:21:50 INFO - Successfully installed mozsystemmonitor 03:21:50 INFO - Cleaning up... 03:21:50 INFO - Return code: 0 03:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:50 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:50 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 03:21:50 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 03:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:50 INFO - 'HOME': '/Users/cltbld', 03:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:50 INFO - 'LOGNAME': 'cltbld', 03:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:50 INFO - 'MOZ_NO_REMOTE': '1', 03:21:50 INFO - 'NO_EM_RESTART': '1', 03:21:50 INFO - 'PAGER': '/bin/cat', 03:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:50 INFO - 'PWD': '/builds/slave/test', 03:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:50 INFO - 'SHELL': '/bin/bash', 03:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:50 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:50 INFO - 'USER': 'cltbld', 03:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:50 INFO - 'XPC_FLAGS': '0x0', 03:21:50 INFO - 'XPC_SERVICE_NAME': '0', 03:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:54 INFO - Downloading docopt-0.6.1.tar.gz 03:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:54 INFO - Running setup.py install for blobuploader 03:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:54 INFO - Running setup.py install for requests 03:21:55 INFO - Running setup.py install for docopt 03:21:55 INFO - Successfully installed blobuploader requests docopt 03:21:55 INFO - Cleaning up... 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:55 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 03:21:55 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 03:21:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:55 INFO - 'HOME': '/Users/cltbld', 03:21:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PAGER': '/bin/cat', 03:21:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test', 03:21:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:55 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - 'XPC_FLAGS': '0x0', 03:21:55 INFO - 'XPC_SERVICE_NAME': '0', 03:21:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:55 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-jcBuIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:55 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7bVPr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:55 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9OHWIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:55 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1YycfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GqpeK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-lnqFV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KMf0yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZZMdLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-c1nFAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RVM_Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-2Jae2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yQULcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-x2xpFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:56 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_akcNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:57 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-smEVVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:57 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TguQcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:57 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KASUj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:57 INFO - Running setup.py install for manifestparser 03:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:57 INFO - Running setup.py install for mozcrash 03:21:57 INFO - Running setup.py install for mozdebug 03:21:57 INFO - Running setup.py install for mozdevice 03:21:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:57 INFO - Running setup.py install for mozfile 03:21:58 INFO - Running setup.py install for mozhttpd 03:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Running setup.py install for mozinfo 03:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Running setup.py install for mozInstall 03:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Running setup.py install for mozleak 03:21:58 INFO - Running setup.py install for mozlog 03:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:58 INFO - Running setup.py install for moznetwork 03:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Running setup.py install for mozprocess 03:21:59 INFO - Running setup.py install for mozprofile 03:21:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Running setup.py install for mozrunner 03:21:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Running setup.py install for mozscreenshot 03:21:59 INFO - Running setup.py install for moztest 03:21:59 INFO - Running setup.py install for mozversion 03:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:59 INFO - Cleaning up... 03:21:59 INFO - Return code: 0 03:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:59 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')]} 03:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 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')]} 03:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:21:59 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 03:21:59 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 03:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:59 INFO - 'HOME': '/Users/cltbld', 03:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:59 INFO - 'LOGNAME': 'cltbld', 03:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:59 INFO - 'MOZ_NO_REMOTE': '1', 03:21:59 INFO - 'NO_EM_RESTART': '1', 03:21:59 INFO - 'PAGER': '/bin/cat', 03:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:59 INFO - 'PWD': '/builds/slave/test', 03:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:59 INFO - 'SHELL': '/bin/bash', 03:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:21:59 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:59 INFO - 'USER': 'cltbld', 03:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:59 INFO - 'XPC_FLAGS': '0x0', 03:21:59 INFO - 'XPC_SERVICE_NAME': '0', 03:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-BMh5JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Aad1pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Rldp8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-m0Vecz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-m8ANF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pRt7th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:00 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)) 03:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:00 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ejpbm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-S1Ok9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zgIxA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-XnEaM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HQzE0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-QvtEY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-y7PBlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7zMARI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-r9Emq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-dwBQsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:01 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)) 03:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:01 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mdlGNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:02 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)) 03:22:02 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)) 03:22:02 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)) 03:22:02 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)) 03:22:02 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)) 03:22:02 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)) 03:22:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22:02 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 03:22:02 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 03:22:02 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 03:22:02 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 03:22:02 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 03:22:02 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 03:22:04 INFO - Downloading blessings-1.6.tar.gz 03:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:04 INFO - Installing collected packages: blessings 03:22:04 INFO - Running setup.py install for blessings 03:22:04 INFO - Successfully installed blessings 03:22:04 INFO - Cleaning up... 03:22:04 INFO - Return code: 0 03:22:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:05 INFO - Reading from file tmpfile_stdout 03:22:05 INFO - Current package versions: 03:22:05 INFO - blessings == 1.6 03:22:05 INFO - blobuploader == 1.2.4 03:22:05 INFO - docopt == 0.6.1 03:22:05 INFO - manifestparser == 1.1 03:22:05 INFO - mozInstall == 1.12 03:22:05 INFO - mozcrash == 0.17 03:22:05 INFO - mozdebug == 0.1 03:22:05 INFO - mozdevice == 0.48 03:22:05 INFO - mozfile == 1.2 03:22:05 INFO - mozhttpd == 0.7 03:22:05 INFO - mozinfo == 0.9 03:22:05 INFO - mozleak == 0.1 03:22:05 INFO - mozlog == 3.1 03:22:05 INFO - moznetwork == 0.27 03:22:05 INFO - mozprocess == 0.22 03:22:05 INFO - mozprofile == 0.28 03:22:05 INFO - mozrunner == 6.11 03:22:05 INFO - mozscreenshot == 0.1 03:22:05 INFO - mozsystemmonitor == 0.0 03:22:05 INFO - moztest == 0.7 03:22:05 INFO - mozversion == 1.4 03:22:05 INFO - psutil == 3.1.1 03:22:05 INFO - requests == 1.2.3 03:22:05 INFO - wsgiref == 0.1.2 03:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:22:05 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 03:22:05 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 03:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:05 INFO - 'HOME': '/Users/cltbld', 03:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:05 INFO - 'LOGNAME': 'cltbld', 03:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:05 INFO - 'MOZ_NO_REMOTE': '1', 03:22:05 INFO - 'NO_EM_RESTART': '1', 03:22:05 INFO - 'PAGER': '/bin/cat', 03:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:05 INFO - 'PWD': '/builds/slave/test', 03:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:05 INFO - 'SHELL': '/bin/bash', 03:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:22:05 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:05 INFO - 'USER': 'cltbld', 03:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:05 INFO - 'XPC_FLAGS': '0x0', 03:22:05 INFO - 'XPC_SERVICE_NAME': '0', 03:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 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)) 03:22:05 INFO - Cleaning up... 03:22:05 INFO - Return code: 0 03:22:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:05 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:22:05 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 03:22:05 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 03:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:05 INFO - 'HOME': '/Users/cltbld', 03:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:05 INFO - 'LOGNAME': 'cltbld', 03:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:05 INFO - 'MOZ_NO_REMOTE': '1', 03:22:05 INFO - 'NO_EM_RESTART': '1', 03:22:05 INFO - 'PAGER': '/bin/cat', 03:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:05 INFO - 'PWD': '/builds/slave/test', 03:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:05 INFO - 'SHELL': '/bin/bash', 03:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:22:05 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:05 INFO - 'USER': 'cltbld', 03:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:05 INFO - 'XPC_FLAGS': '0x0', 03:22:05 INFO - 'XPC_SERVICE_NAME': '0', 03:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:05 INFO - Downloading/unpacking jsonschema 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:08 INFO - Downloading/unpacking functools32 (from jsonschema) 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:08 INFO - warning: no files found matching '*.txt' 03:22:08 INFO - no previously-included directories found matching 'build' 03:22:08 INFO - no previously-included directories found matching 'dist' 03:22:08 INFO - no previously-included directories found matching '.git*' 03:22:08 INFO - Installing collected packages: jsonschema, functools32 03:22:08 INFO - Running setup.py install for functools32 03:22:08 INFO - warning: no files found matching '*.txt' 03:22:08 INFO - no previously-included directories found matching 'build' 03:22:08 INFO - no previously-included directories found matching 'dist' 03:22:08 INFO - no previously-included directories found matching '.git*' 03:22:08 INFO - Successfully installed jsonschema functools32 03:22:08 INFO - Cleaning up... 03:22:08 INFO - Return code: 0 03:22:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22:08 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')]} 03:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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')]} 03:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:08 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 0x10c952a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c962420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff209594250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, '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.uyUG2ClkHW/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.yxMDErSJed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 03:22:08 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 03:22:08 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 03:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:08 INFO - 'HOME': '/Users/cltbld', 03:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PAGER': '/bin/cat', 03:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:22:08 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - 'XPC_FLAGS': '0x0', 03:22:08 INFO - 'XPC_SERVICE_NAME': '0', 03:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:09 INFO - Downloading/unpacking flake8 03:22:09 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 03:22:09 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 03:22:09 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 03:22:09 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 03:22:09 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 03:22:09 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 03:22:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:12 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 03:22:12 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 03:22:12 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 03:22:12 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 03:22:12 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 03:22:12 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 03:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:12 INFO - no previously-included directories found matching 'docs/_build' 03:22:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:12 INFO - Running setup.py install for pep8 03:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:13 INFO - no previously-included directories found matching 'docs/_build' 03:22:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:13 INFO - Cleaning up... 03:22:13 INFO - Return code: 0 03:22:13 INFO - Running post-action listener: _resource_record_post_action 03:22:13 INFO - Running post-action listener: _start_resource_monitoring 03:22:13 INFO - Starting resource monitoring. 03:22:13 INFO - ##### 03:22:13 INFO - ##### Running install step. 03:22:13 INFO - ##### 03:22:13 INFO - Running pre-action listener: _resource_record_pre_action 03:22:13 INFO - Running main action method: install 03:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:13 INFO - Reading from file tmpfile_stdout 03:22:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:13 INFO - Reading from file tmpfile_stdout 03:22:13 INFO - Output received: 03:22:13 INFO - Usage: mozinstall [options] installer 03:22:13 INFO - Options: 03:22:13 INFO - -h, --help show this help message and exit 03:22:13 INFO - -d DEST, --destination=DEST 03:22:13 INFO - Directory to install application into. [default: 03:22:13 INFO - "/builds/slave/test"] 03:22:13 INFO - --app=APP Application being installed. [default: firefox] 03:22:13 INFO - mkdir: /builds/slave/test/build/application 03:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:22:35 INFO - Reading from file tmpfile_stdout 03:22:35 INFO - Output received: 03:22:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:22:35 INFO - Running post-action listener: _resource_record_post_action 03:22:35 INFO - ##### 03:22:35 INFO - ##### Running run-tests step. 03:22:35 INFO - ##### 03:22:35 INFO - Running pre-action listener: _resource_record_pre_action 03:22:35 INFO - Running main action method: run_tests 03:22:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:35 INFO - 2016-07-08 03:22:35.516 screenresolution[1926:18284] starting screenresolution argv=screenresolution get 03:22:35 INFO - 2016-07-08 03:22:35.518 screenresolution[1926:18284] Display 0: 1600x1200x32@60 03:22:35 INFO - 2016-07-08 03:22:35.523 screenresolution[1927:18286] starting screenresolution argv=screenresolution list 03:22:35 INFO - Available Modes on Display 0 03:22:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:35 INFO - Intel Iris: 03:22:35 INFO - Chipset Model: Intel Iris 03:22:35 INFO - Type: GPU 03:22:35 INFO - Bus: Built-In 03:22:35 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:35 INFO - Vendor: Intel (0x8086) 03:22:35 INFO - Device ID: 0x0a2e 03:22:35 INFO - Revision ID: 0x0009 03:22:35 INFO - Displays: 03:22:35 INFO - Display: 03:22:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:35 INFO - Display Serial Number: 1600x1200 60 03:22:35 INFO - Main Display: Yes 03:22:35 INFO - Mirror: Off 03:22:35 INFO - Online: Yes 03:22:35 INFO - Rotation: Supported 03:22:35 INFO - Return code: 0 03:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:35 INFO - Python 2.7.3 03:22:35 INFO - Return code: 0 03:22:35 INFO - grabbing minidump binary from tooltool 03:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:22:35 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 0x10c7f1e00>, '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 0x10c65adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7ecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:35 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 03:22:35 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 03:22:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:35 INFO - Return code: 0 03:22:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:36 INFO - Return code: 0 03:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uyUG2ClkHW/Render', 03:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:36 INFO - 'HOME': '/Users/cltbld', 03:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:36 INFO - 'LOGNAME': 'cltbld', 03:22:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:36 INFO - 'MOZ_NO_REMOTE': '1', 03:22:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:36 INFO - 'NO_EM_RESTART': '1', 03:22:36 INFO - 'PAGER': '/bin/cat', 03:22:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:36 INFO - 'PWD': '/builds/slave/test', 03:22:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:36 INFO - 'SHELL': '/bin/bash', 03:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxMDErSJed/Listeners', 03:22:36 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 03:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:36 INFO - 'USER': 'cltbld', 03:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:36 INFO - 'XPC_FLAGS': '0x0', 03:22:36 INFO - 'XPC_SERVICE_NAME': '0', 03:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:22:37 INFO - mozversion application_buildid: 20160708021326 03:22:37 INFO - mozversion application_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 03:22:37 INFO - mozversion application_display_name: Firefox 03:22:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:37 INFO - mozversion application_name: Firefox 03:22:37 INFO - mozversion application_remotingname: firefox 03:22:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:22:37 INFO - mozversion application_vendor: Mozilla 03:22:37 INFO - mozversion application_version: 48.0 03:22:37 INFO - mozversion platform_buildid: 20160708021326 03:22:37 INFO - mozversion platform_changeset: 75b9cc8259df0aca3d93c4b44155a77875341a14 03:22:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:22:37 INFO - mozversion platform_version: 48.0 03:22:37 INFO - using testdate: 1467973357 03:22:37 INFO - actual date: 1467973357 03:22:37 INFO - starting webserver on 'localhost:52823' 03:22:37 INFO - SUITE-START | Running 2 tests 03:22:37 INFO - TEST-START | dromaeo_css 03:22:37 INFO - operating with platform_type : mac_ 03:22:37 INFO - Initialising browser for dromaeo_css test... 03:22:37 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpCmLxWC/profile http://localhost:52823/getInfo.html) 03:22:39 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 03:22:39 INFO - PROCESS | 1945 | colorDepth:24 03:22:39 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 03:22:39 INFO - PROCESS | 1945 | __metrics 03:22:39 INFO - PROCESS | 1945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:22:39 ERROR - PROCESS | 1945 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:22:40 INFO - TEST-INFO | 1945: exit 0 03:22:40 INFO - Browser initialized. 03:22:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:40 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpCmLxWC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:52 INFO - PROCESS | 1948 | RSS: Main: 161914880 03:22:52 INFO - PROCESS | 1948 | 03:23:43 INFO - PROCESS | 1948 | 1467973423208 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] 03:25:52 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52823/tests/dromaeo/cssquery-ext.html) 03:25:54 INFO - PROCESS | 1948 | RSS: Main: 249618432 03:25:54 INFO - PROCESS | 1948 | 03:28:56 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-ext.html (next: http://localhost:52823/tests/dromaeo/cssquery-jquery.html) 03:28:57 INFO - PROCESS | 1948 | RSS: Main: 299663360 03:28:57 INFO - PROCESS | 1948 | 03:31:59 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52823/tests/dromaeo/cssquery-mootools.html) 03:32:00 INFO - PROCESS | 1948 | RSS: Main: 307908608 03:32:00 INFO - PROCESS | 1948 | 03:35:02 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52823/tests/dromaeo/cssquery-prototype.html) 03:35:02 INFO - PROCESS | 1948 | RSS: Main: 301166592 03:35:02 INFO - PROCESS | 1948 | 03:38:05 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52823/tests/dromaeo/cssquery-yui.html) 03:38:06 INFO - PROCESS | 1948 | RSS: Main: 267042816 03:38:06 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:52823/tests/dromaeo/cssquery-yui.html (next: http://localhost:52823/tests/dromaeo/cssquery-dojo.html) 03:41:09 INFO - PROCESS | 1948 | RSS: Main: 311402496 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | __start_tp_report 03:41:09 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 03:41:09 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 03:41:09 INFO - PROCESS | 1948 | |i|pagename|runs| 03:41:09 INFO - PROCESS | 1948 | |0;dojo.html;3473.6526347365257;3585.1216451969262;3587.1390866192123;3602.513660655812;3648.197396572753;5822.515977928629;5825.30096388433;5859.824205273849;5891.675957822324;5919;5835.328937172216;5886.970565147169;5911.556633252501;5911.9408805912035;5920.259967504062;5252.290940722992;5268;5289.471052894699;5331.040412725708;5369.328833895763;5272.420033796279;5336.092864213093;5338.359396872381;5343.251944727741;5349.22436246744;5268.367795864501;5327.733613319338;5332.733363331818;5361.061814182522;5362.865928351803;5315.36215654122;5330.28041214435;5339.466053394668;5348.358197016344;5368.865778355534;5144.897102057976;5202.297689811865;5274.208868669692;5282.075636763551;5292.523672869422;4263.4031235627035;5731.312242530923;5735.971320143414;5771.826845194651;5775.220345253421;6316.957701979214;6333.87332253357;6337.176167098294;6338.144350512668;6338.6196828189995;5179.792808287664;6143.911070236097;6284.277308109535;6291.245050593912;6338.841528961767;5852.619579727347;5895.263092113486;5908.645481271137;5908.67502287374;5912.674802885796;6408.871822563523;6411.070394792729;6415.518836087219;6419.293877673452;6426.35736426363;6126.456603435116;6180.752769889244;6258.186435763321;6265.404786545271;6290.528210384239;6280.026595877646;6312.274088479791;6324.557280990287;6331.145295385156;6339.080833279241;6289.465395441347;6315.052742088632;6331.303556608769;6344.302126766052;6363.9045414318825;6180.443760061616;6273.404026617464;6289.937100629027;6290;6322.652254125976;4229.407882896397;4990.650654454226;5043.470435604208;5045.672031318026;5056.646034777604;4484.439445069366;4484.955150448519;4500.279955207151;4506.414166158378;4543.954560454419;5969.462748352669;6044.063170208625;6052.455279024909;6095.847603809941;6103.450689437883;6233.3143354231;6287.182666253358;6302.873942521124;6319.146915166394;6322.71547780351;5038.974805125951;6066.998945174085;6069.666168360694;6081.422264884829;6095.207623009069;5445.156000819879;5471.37079235885;5483.698396588146;5521;5534.418886016911;6485.77299794505;6582.440492558187;6583.967080164569;6588.934110658832;6591.242007169237;6290.842728931813;6298.433141017331;6314.463270622048;6315.96842015787;6335.65153916539;6407.359264073555;6450.645214513247;6580.144581204413;6589.0116482528;6617.7683781067435;6270.498360131087;6282.246130464374;6318.589291696025;6327.525435592441;6329.810105696836;5202.73986300691;5238.214267859851;6244.157038799885;6286.339934306832;6289.245290564979;6106.794380079809;6191.845203869759;6257.624542527463;6257.812265632038;6275.058741188858;6158.661273629814;6221.720022599085;6222.066689996536;6223.253209614875;6226.066090086523;5100.770465328995;5964.582479226413;6115.4190351916495;6142.662153581596;6145.72344244519;6109.572329937039;6126.884121540821;6233.75064997395;6248.562600617913;6274.215723034621;6144.17053697763;6164.321924588381;6166.537509686702;6174.073888916699;6181.474574661024 03:41:09 INFO - PROCESS | 1948 | |1;ext.html;531.1607659897362;547.2693953571982;578.943404752043;588.5203559099331;593.3265743381262;33295;33935.15162120948;41343.17313653729;41345.37981930273;41402;44466.555334446646;44943.77528112363;45044;45047.0990580189;45067.77466112665;9218.446893186398;9745.463999480044;9949;9961.203103751683;11904.7619047619;11892.989095926856;12013.939930300336;12015.519379224821;12019.338936358497;12021.278723276631;11957;12017.699557511089;12034.939825300862;12043.518259269662;12050.276983380982;11900.583479578216;11930.701732456671;12004.219725717887;12021.699457513545;12036.81944770829;11849.703757406047;11974.461149248305;11979.700507487383;12205.962493188;12232.633021009384;43226;43532.56467435317;43674.56325436737;43697.563024369665;43734;3313.8177400242976;3487.9651203488147;3647.361711700442;3705.6479634434686;3959.5248570171475;27383.86308068447;29698.70301296981;30210.395792084255;30814.69185308163;30840.228994275098;2750.7386798254333;2775.9028434004713;2821.661400631917;2834.008097165996;2872.8563571821323;504391.9560804418;506205;506516;507531;509755;38179.85460436191;38657.42013869794;38710;68909.2772680687;69494.65252673805;37381.813090934374;37623.435648465296;37639.4354084689;37733.24533509315;37733.43399849004;15625.296861641253;15808.920955395379;16496.17519124039;16691.99848009123;16693.582660433585;12518.561850335194;13199.736005280032;13410.932945335211;14217.64455888611;14257.21585312797;7795.649195786204;8189;8539.701110461105;8565.400421970528;8705.216530512283;3578.302231064917;3596.2447885944243;3604.3151801157696;3621.583517895476;3636.927261454809;818.4639061414783;1039.0181278691564;1071.4696225368493;1086.7554800169898;1133.0822034152363;31105.377892442026;31428.842855785573;31450.37099258048;31583.733467905073;31681.366372672877;1057.0275346681071;1109.8501702270253;1215.9878401216051;1231.7228623559806;1296.9805452918213;16209.675806483805;16228.83771162297;16229.91885040591;16339.918300408659;16354.427595034354;556877;562840;563206;563957.1802140963;564182;65501;66284.33715662878;66345.66827165833;66379;66382;1423.7650787620134;1587.952361429159;1608;1625.5610985033975;1673.4226691791312;24363.878180608983;29497.820087196273;29896.402071958873;30362.392752145275;31327.530087048257;52607.68480788011;52935.73532132315;53048.73475632597;53065;53117.7344113277;416837;425718;426357.8682106694;427644;428301;25115.623265651397;28132.71867281383;28803.70383332713;28950.42099158047;29177.270568235963;44656.553434466536;45831.54168458406;46247.53752462432;46384.768076160755;46732;35200.47199292064;35938;36811.26377472489;37379.81310093432;37625.24749505049;33907;35431.82284088563;38246;38720.41919371268;39204.66116638473;38148.80925595354;38478;38560.80719596496;38831.2233755329;39156.80421597988;27020.864895675397;32805.507917381736;33581.83209083939;33660.158496037795;33875.4918676225;25505;25507.74492255128;25546.489070218864;25590;26121.955121795676 03:41:09 INFO - PROCESS | 1948 | |2;jquery.html;413.40882537970697;414.0952019836656;414.92946199146144;417.30935302075056;426.96584273258145;20629.27797527087;21274.36176914693;21303.893480532595;21806.236781712643;22811.885940570315;12609.865112139905;12610.495580176805;12625.431855566498;15637.452689155882;21576.784232157675;5276.393214780311;5407.945920540803;5545;5576.944230557703;5577.637453565505;6029.035354343306;6093.969530152343;6127.662978536178;6139.662318572477;6164.630122192661;5904.3800400957925;6162.599431036991;6167.537434692416;6168.660723660197;6179.165812615307;6067.908981365283;6091.51267898567;6125.356837532062;6126.7549298028025;6130.172426722403;5721.342045664718;5898.528117750569;5924.140999555084;6084.878302433971;6094.481969032638;26258.474830503284;26344.814483348295;26579.601305980425;26775.598366024526;26801.597976030374;2082.37528741377;2157.331227319536;2223.3663405929233;2776.0977682253147;2834.7590454811366;9202.263818894473;9720.951395242979;9885.406875587487;10239.822420421673;10409.479526023744;1805.1024096087278;1824.6898027335253;1867.738516607676;1868.1126464929187;1883.6421079994893;69757.2560685987;102916.48541757319;105297;115356.69286614221;122549;9905.306628535933;12000.939995300143;12035.819462708067;12039.097067719957;12057.939710301393;14199.36102875373;14581.927090364481;14584.854151458561;14860.851391485947;15353.002054866622;9028;9062.50156241413;9227.077292270718;9232.446053236827;9324.90675093254;9232.21526170283;9235.353525253302;9260.351775375793;9319.953400233091;9379.718608441757;3918.275119102975;4138.710290279651;4622.537746225351;4745.738984355825;4794.352762377104;1721.5007647782254;2002.2691717522998;2013.7784843667184;2047.1708957872086;2069.2136987944486;916.9312301577409;995.9701208963743;1034.6533911139702;1070.106461104986;1099.7580532282884;19690.40928772139;20539.28112516055;20544.691829622567;20888.47778805542;20893.582128357346;897.717219075989;983.5279066048193;992.1021475564626;998.3710262534556;1034.9223808214415;10714.46427678613;11197.16021298406;11237.044851187577;11246.831297530543;11274.436278186058;614110;614829;617807;628940;660501;101328;110715;113629;123153;124414;1052.1162223732101;1063.0857462582173;1077.9514921828536;1078.8489611454402;1084.1218612923558;18079.45761627153;18217.908910455364;18396;18586.721199181753;18964.620707586048;46639.76680116577;46878.76560617175;49347.25979110388;49410.752946235036;50895.982080358925;66339;68576.62846743136;69802.65098674475;70509.64745176242;70902.29097709163;8277;8339.95830020846;8415.789605259917;8459.280961118375;8771.16673915977;8047.034355877332;9359;12817.359132043173;13052.34738263064;13250.072494925264;11207.374930634849;11314.151438642299;11375.1468639854;11565.884341156481;11729.061675065803;9160.496172710566;9221.182556246687;11304.49129789145;11396.2592431495;11461.968422841985;11270.661880143609;11581.189316747746;11581.768364632828;11596;11771.117166212398;7203.351698347174;8302.460340077876;8324.25081742646;8331.791705207419;8420.284275836622;10384.792304153723;11382.203245772716;11491.482883270106;11566.421678915853;11697.2981621103 03:41:09 INFO - PROCESS | 1948 | |3;mootools.html;1418.0144799364446;1604.7352186889161;1623.9188040597974;1883.585611165544;1991.502124468882;6995.230524642286;8687.913120868789;8835.558222088886;8850.822983540325;8876.33427492939;8481.491110533358;8561.91438085619;8723.694670686527;8740.43187192832;8751.081136480674;2477.6902887139154;2504.2362079565723;2507.2227609441043;2509.2472258322523;2510.949781004388;2437.025189924027;2495.25142457263;2497.5379554782335;2503.324102492326;2505.4863752930696;2085.4786303424144;2411.770881766229;2502.687164104487;2506.310764539757;2508.2600632813273;2452.6934133233344;2487.56467618167;2489.9004039838474;2502.336880726609;2507.761762632547;2447.167962892625;2479.7148327942336;2491.364702000996;2496.2636022373445;2504.749525047499;8530.658773649047;8727.345449091343;8778.736637900873;8781.824363512758;8793.076726943642;5285.207218917155;5437.966786310589;5445;5480.013597552439;5503.3395992480755;3507.94738078929;3548.6806187442994;3559.519464872261;3614.8734794282072;3635.4910312556;907.3512438606363;943.9952800236024;1051.7002654243504;1087.2986923434419;1097.7091070866227;11459;11559.422028898522;11716.999999999915;11723.472443739967;11734.354610496419;4579.564941330568;4652.092841895797;4737.360456338419;4744.857654270378;4757.9286310705365;7504.474686771873;9072.81854362909;9198.586063627154;9203.309751768644;9206;5241.50205730455;5296.311479507639;5302.708351040653;5306.54894333986;5322.787088516416;3672.7061835053664;4563.680542362003;4820.783064762024;4896.951030489649;4993.575546078551;3831.3869780834934;3879.8836034919;3945.9605403945593;3948.9930067833093;3974.503187101612;1202.6788298583817;1203.1457665057908;1204.560335477562;1210.5581462766027;1221.8717034711406;902.7923577577062;953.2326477185932;964.1563631822156;979.299800642544;1014.3153371474225;5511.421300763443;5861.263132664842;5910.231669882888;5992.280926288786;6073.6659483727935;481.54734549523334;485.3738677106493;494.6067876038558;496.6275293529853;502.3544745002654;3934.4885164928946;3965.1871366369824;4039.8788036358956;4103.2409004334295;4107.486564179478;10343.224258180666;10855.40295283767;10888.727781805519;10895.727606809734;10899.400532970763;8366.330693544502;9961.35251208669;10425.530851111718;10673.41296228715;10679.466026698634;8122.55325957078;8319.043310019426;8323.83352332962;8354.58227088643;8372.246497815226;5636.718164091861;5873.177755114373;5980.820575382745;6013.609115407659;6176.980798168252;9322.673706420243;9496.43021418717;9516.238700903772;9612.1829644481;9684.903150968681;7770.339521140766;9334.859977100214;9770;9803.901960980298;9948.303618746619;6820.62486563224;7046.859062818818;7264.491485596169;7533.698652053857;7603.2776886195725;8214.876776848472;8239.835203295781;8274.917250827655;8304.169583041648;8311.792205194919;7235.674394652358;7332.523385979895;7360.116785985502;7489.363404110712;7498.137714162941;7166.162483847104;7335.9729637851815;7386.926130738624;7415.888761668687;7430.517016393917;7008.439324853897;7089.539179953286;7107.431405487445;7108.360247577536;7113.928860711327;4879.292502587034;4910.337104490991;4944.456109827988;5041.722705251246;5044.4198917125;4985.1276026695905;5004.674696144884;5059.974700126623;5150.072986862401;5316.548093412103 03:41:09 INFO - PROCESS | 1948 | |4;prototype.html;328.4498465071006;330.85029522409627;338.80349397349534;342.17706416069365;344.2289272030652;6729.0915726376925;6730.519285757138;6751.25736169021;6780.35586619271;6795.626240556768;6651.4678825693945;6691.698873550689;6757.391834734885;6774;6778.661066946657;4681.648876334271;4847.709137451764;4877.097736918681;4888.340074090006;4891.290762839386;4759.85720428386;4857.29569212464;4908.460069392364;4926.753662316888;4998;4826.3001864729595;4882.829100981467;4898.093852637274;4907.460179380265;4917.139500587401;4009.1981603679087;4778.474367819537;4902.754862256891;4918.2376731606655;4918.557329840296;4013.2776100301935;4079.9592004079877;4164.312888373414;4186.748795072275;4213.9578604214175;6471.191101112361;6489.870202595922;6498.252700939405;6498.415142637185;6532.902006469907;4742.383490146259;5862.091375836752;5871.412858714137;5877.147813567051;5884.6763428011445;5797.594168408213;6062.848428789272;7134.785956421316;7135.964320178417;7156;4577.29051996941;4720.952790472085;4729.59798417135;4729.929051064237;4742.241241401393;6101.969490152521;7592.316691497736;7608.277213664693;7610.1628820829665;7618.695252189906;4841.346418233564;4875.390576177978;4884.169691152512;4885.316055752198;4886.95113048865;4430.379746835446;4696.342512048316;4984.177610694267;4985.576226020757;4995.850954280463;4728.668993170445;5887.264091988502;5912.320083190488;5915.64506129625;5916.704164791743;7009.410054417241;7172.677229524684;7222.674979625929;7233.204347521769;7236;1473.5652982370011;1698.1169791708242;1702.4637239269591;1721.8536424403815;1723.9827601724073;1098.4562641492512;1099.1701265544464;1114.6098865397207;1117.3240189685123;1120.0367683792094;6667.766628167991;6850.588964662136;6904.240533541307;6921.238663746984;6923.480738944499;7294.671739771723;7429;7442.21856705049;7448.776536703907;7453.031105956299;5658.971705141448;6948.791536253921;6958.373746362851;6959.4432445405255;6963.547369421073;3924.3132451820816;3983.701222408331;3986.5614782373914;3987.92024159521;3996.5603783583783;7664.578448185292;7904.802379940547;7917.564533950688;7935.64289606969;7944.523328600187;7689.154193038761;7719.729809456642;7736.690532378641;7737.613119344011;7748;6687.899681504781;7595.050618672666;7858.764237072897;7871.685132594746;7903.288704016666;7457.291557302047;7473.850522989618;7479.139898911477;7490;7494.437917156126;7073.504854660125;7330.340269375782;7338.6697598607125;7340.816479588053;7362.926370736438;7805.4536182468955;7838.843223135391;7859.135495095649;7871.094824095073;7946.92053079485;4237.78811059452;4884.902301954012;4889.413270407574;4893.804247830047;4899.3385892904;7465.813354666177;7468.991686122304;7472.439567032386;7472.962635186789;7492.175860655432;6933.237343892269;7222.386097181588;7223.963880180566;7230.45771567124;7266;7138.214796372291;7181.102362204724;7187.353138217585;7194.028806111317;7208.27917208275;7059.2940705928995;7064.682089306097;7064.964675176591;7073.610951397723;7075.5047146699235;6986;7199.280071992759;7235.023271858442;7235.131784185932;7249.383802376857;6774.153230846145;7088.397486213729;7092.645367731489;7104.893426598502;7115.1106111736035 03:41:09 INFO - PROCESS | 1948 | |5;yui.html;718.5544962123485;759.5632511306001;771.3674786674928;783.9686412543497;806.9556174410405;15428.69142617147;15430.922845385772;15524.534263972071;15611.29749161289;15619.921900390496;14671.486497972573;14891.25543722815;14891.702165956674;14927.104373737557;14953.327100280487;796.5738329993454;809.0857331215718;955.7610597350663;958.8417911044669;985.7437066362726;975.0639386189231;994.060612720979;994.636957510507;995.3828626251734;998.4009594243432;1005.3264312910368;1020.2450186861706;1020.6835880876915;1020.7652239984808;1022.8465730140464;826.5908375354209;840.4453060979724;842.9957850210772;845.5222799118478;998.0817647764038;766.3715753082474;773.261535233856;780.6955287437847;784.1726978038167;784.8587254294225;15940.521784346372;16004.75992860108;16021.439249626206;16030.83969160305;16108.275127619285;13159.802602960963;13175.275359855204;13200.6699832504;13475.730485390237;13508.257045862474;10235.590576376935;10457.111145552637;11138.33170009802;11170.273932194463;11567.826482602768;3566.5006899034156;3614.7650402724003;3639.945400818963;3642.6357364263627;3757.7181711371754;87056;88889.55555222247;89271;89535.55232223863;89955;9653.855192172123;10132.442715650563;10334.224933130045;10405.42770147634;10513.84229236562;23486.295411137693;23490.295291141294;23494;23494.64758028631;23531.17640882561;7705;7706.807329816799;7769.300762931363;7889.17163697815;8117.918820811717;4251.659867210616;4393.1872603568445;4400.141972315432;4401.603855653007;4588.655850811202;3754.4180651998986;3814.790186539767;3822.1591249924973;3826.6364695353896;3833.789141597239;599.9040153575407;618.5113760129448;620.4571000374672;667.3060017581757;695.2074634916199;551.3686828581332;568.2186992884783;606.2028432611103;626.5770604841714;642.6208536963214;7964.685826838507;8174.427790054758;8279.62741676626;8409.453385529921;8468.830623387497;485.8493866901272;578.5805291163872;604.5314880967286;607.3531688751466;629.8330942300294;3798.8290526926353;3945.447637330776;3999.1601763629383;4104.753714777123;4159.854405095807;83860.16139838523;85877.71183432253;85902;85936;85989.14010859812;79522.20477795148;80844.19155808484;80935;81771;82385;69523.3047669527;71407.2859271411;72109;73253.63373183207;73773;7885.329746971572;7912.406569507425;8007.35941124697;8113.310368618733;8541.743747687578;35758;47327;47980.04039919112;48731.75634121807;49336.25995610141;45283.54716452925;60270.39729602648;70385.64807175931;71050.57898842098;71963.64018179875;11246.66260012201;11316.26444281119;11399.430028498376;11530.884691152982;12186.695332616755;11983.28100313984;12013.81979270329;12268.815967760669;12280.263184208976;12901.548445804352;11798.823017654913;11830.704232394259;11858.16992810495;11926.880731192578;12038.75922481528;11700.70748231301;11793.823092653789;11796.16153498897;11803.940980295043;11930.940345298219;11501.769964600493;11707.180497365443;11793.941030295136;11848.052155827341;12074.698132546757;10145.985401459795;10228.693139205538;10285;10440.42577658236;10468.790624187626;9733.707988760349;9997.950010249902;10218.897811021794;10238.846417303896;10276 03:41:09 INFO - PROCESS | 1948 | __end_tp_report 03:41:09 INFO - PROCESS | 1948 | __start_cc_report 03:41:09 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,1121 03:41:09 INFO - PROCESS | 1948 | __end_cc_report 03:41:09 INFO - PROCESS | 1948 | __startTimestamp1467974469391__endTimestamp 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | ------- Summary: start ------- 03:41:09 INFO - PROCESS | 1948 | Number of tests: 6 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#0] dojo.html Cycles:165 Average:5833.39 Median:6115.42 stddev:663.82 (10.9%) stddev-sans-first:639.52 03:41:09 INFO - PROCESS | 1948 | Values: 3473.7 3585.1 3587.1 3602.5 3648.2 5822.5 5825.3 5859.8 5891.7 5919.0 5835.3 5887.0 5911.6 5911.9 5920.3 5252.3 5268.0 5289.5 5331.0 5369.3 5272.4 5336.1 5338.4 5343.3 5349.2 5268.4 5327.7 5332.7 5361.1 5362.9 5315.4 5330.3 5339.5 5348.4 5368.9 5144.9 5202.3 5274.2 5282.1 5292.5 4263.4 5731.3 5736.0 5771.8 5775.2 6317.0 6333.9 6337.2 6338.1 6338.6 5179.8 6143.9 6284.3 6291.2 6338.8 5852.6 5895.3 5908.6 5908.7 5912.7 6408.9 6411.1 6415.5 6419.3 6426.4 6126.5 6180.8 6258.2 6265.4 6290.5 6280.0 6312.3 6324.6 6331.1 6339.1 6289.5 6315.1 6331.3 6344.3 6363.9 6180.4 6273.4 6289.9 6290.0 6322.7 4229.4 4990.7 5043.5 5045.7 5056.6 4484.4 4485.0 4500.3 4506.4 4544.0 5969.5 6044.1 6052.5 6095.8 6103.5 6233.3 6287.2 6302.9 6319.1 6322.7 5039.0 6067.0 6069.7 6081.4 6095.2 5445.2 5471.4 5483.7 5521.0 5534.4 6485.8 6582.4 6584.0 6588.9 6591.2 6290.8 6298.4 6314.5 6316.0 6335.7 6407.4 6450.6 6580.1 6589.0 6617.8 6270.5 6282.2 6318.6 6327.5 6329.8 5202.7 5238.2 6244.2 6286.3 6289.2 6106.8 6191.8 6257.6 6257.8 6275.1 6158.7 6221.7 6222.1 6223.3 6226.1 5100.8 5964.6 6115.4 6142.7 6145.7 6109.6 6126.9 6233.8 6248.6 6274.2 6144.2 6164.3 6166.5 6174.1 6181.5 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#1] ext.html Cycles:180 Average:63607.89 Median:35316.15 stddev:133478.76 (378.0%) stddev-sans-first:133769.19 03:41:09 INFO - PROCESS | 1948 | Values: 531.2 547.3 578.9 588.5 593.3 33295.0 33935.2 41343.2 41345.4 41402.0 44466.6 44943.8 45044.0 45047.1 45067.8 9218.4 9745.5 9949.0 9961.2 11904.8 11893.0 12013.9 12015.5 12019.3 12021.3 11957.0 12017.7 12034.9 12043.5 12050.3 11900.6 11930.7 12004.2 12021.7 12036.8 11849.7 11974.5 11979.7 12206.0 12232.6 43226.0 43532.6 43674.6 43697.6 43734.0 3313.8 3488.0 3647.4 3705.6 3959.5 27383.9 29698.7 30210.4 30814.7 30840.2 2750.7 2775.9 2821.7 2834.0 2872.9 504392.0 506205.0 506516.0 507531.0 509755.0 38179.9 38657.4 38710.0 68909.3 69494.7 37381.8 37623.4 37639.4 37733.2 37733.4 15625.3 15808.9 16496.2 16692.0 16693.6 12518.6 13199.7 13410.9 14217.6 14257.2 7795.6 8189.0 8539.7 8565.4 8705.2 3578.3 3596.2 3604.3 3621.6 3636.9 818.5 1039.0 1071.5 1086.8 1133.1 31105.4 31428.8 31450.4 31583.7 31681.4 1057.0 1109.9 1216.0 1231.7 1297.0 16209.7 16228.8 16229.9 16339.9 16354.4 556877.0 562840.0 563206.0 563957.2 564182.0 65501.0 66284.3 66345.7 66379.0 66382.0 1423.8 1588.0 1608.0 1625.6 1673.4 24363.9 29497.8 29896.4 30362.4 31327.5 52607.7 52935.7 53048.7 53065.0 53117.7 416837.0 425718.0 426357.9 427644.0 428301.0 25115.6 28132.7 28803.7 28950.4 29177.3 44656.6 45831.5 46247.5 46384.8 46732.0 35200.5 35938.0 36811.3 37379.8 37625.2 33907.0 35431.8 38246.0 38720.4 39204.7 38148.8 38478.0 38560.8 38831.2 39156.8 27020.9 32805.5 33581.8 33660.2 33875.5 25505.0 25507.7 25546.5 25590.0 26122.0 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#2] jquery.html Cycles:180 Average:34651.01 Median:26677.60 stddev:103805.06 (389.1%) stddev-sans-first:104064.42 03:41:09 INFO - PROCESS | 1948 | Values: 413.4 414.1 414.9 417.3 427.0 20629.3 21274.4 21303.9 21806.2 22811.9 12609.9 12610.5 12625.4 15637.5 21576.8 5276.4 5407.9 5545.0 5576.9 5577.6 6029.0 6094.0 6127.7 6139.7 6164.6 5904.4 6162.6 6167.5 6168.7 6179.2 6067.9 6091.5 6125.4 6126.8 6130.2 5721.3 5898.5 5924.1 6084.9 6094.5 26258.5 26344.8 26579.6 26775.6 26801.6 2082.4 2157.3 2223.4 2776.1 2834.8 9202.3 9721.0 9885.4 10239.8 10409.5 1805.1 1824.7 1867.7 1868.1 1883.6 69757.3 102916.5 105297.0 115356.7 122549.0 9905.3 12000.9 12035.8 12039.1 12057.9 14199.4 14581.9 14584.9 14860.9 15353.0 9028.0 9062.5 9227.1 9232.4 9324.9 9232.2 9235.4 9260.4 9320.0 9379.7 3918.3 4138.7 4622.5 4745.7 4794.4 1721.5 2002.3 2013.8 2047.2 2069.2 916.9 996.0 1034.7 1070.1 1099.8 19690.4 20539.3 20544.7 20888.5 20893.6 897.7 983.5 992.1 998.4 1034.9 10714.5 11197.2 11237.0 11246.8 11274.4 614110.0 614829.0 617807.0 628940.0 660501.0 101328.0 110715.0 113629.0 123153.0 124414.0 1052.1 1063.1 1078.0 1078.8 1084.1 18079.5 18217.9 18396.0 18586.7 18964.6 46639.8 46878.8 49347.3 49410.8 50896.0 66339.0 68576.6 69802.7 70509.6 70902.3 8277.0 8340.0 8415.8 8459.3 8771.2 8047.0 9359.0 12817.4 13052.3 13250.1 11207.4 11314.2 11375.1 11565.9 11729.1 9160.5 9221.2 11304.5 11396.3 11462.0 11270.7 11581.2 11581.8 11596.0 11771.1 7203.4 8302.5 8324.3 8331.8 8420.3 10384.8 11382.2 11491.5 11566.4 11697.3 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#3] mootools.html Cycles:180 Average:5631.57 Median:5195.79 stddev:3092.97 (59.5%) stddev-sans-first:3085.43 03:41:09 INFO - PROCESS | 1948 | Values: 1418.0 1604.7 1623.9 1883.6 1991.5 6995.2 8687.9 8835.6 8850.8 8876.3 8481.5 8561.9 8723.7 8740.4 8751.1 2477.7 2504.2 2507.2 2509.2 2510.9 2437.0 2495.3 2497.5 2503.3 2505.5 2085.5 2411.8 2502.7 2506.3 2508.3 2452.7 2487.6 2489.9 2502.3 2507.8 2447.2 2479.7 2491.4 2496.3 2504.7 8530.7 8727.3 8778.7 8781.8 8793.1 5285.2 5438.0 5445.0 5480.0 5503.3 3507.9 3548.7 3559.5 3614.9 3635.5 907.4 944.0 1051.7 1087.3 1097.7 11459.0 11559.4 11717.0 11723.5 11734.4 4579.6 4652.1 4737.4 4744.9 4757.9 7504.5 9072.8 9198.6 9203.3 9206.0 5241.5 5296.3 5302.7 5306.5 5322.8 3672.7 4563.7 4820.8 4897.0 4993.6 3831.4 3879.9 3946.0 3949.0 3974.5 1202.7 1203.1 1204.6 1210.6 1221.9 902.8 953.2 964.2 979.3 1014.3 5511.4 5861.3 5910.2 5992.3 6073.7 481.5 485.4 494.6 496.6 502.4 3934.5 3965.2 4039.9 4103.2 4107.5 10343.2 10855.4 10888.7 10895.7 10899.4 8366.3 9961.4 10425.5 10673.4 10679.5 8122.6 8319.0 8323.8 8354.6 8372.2 5636.7 5873.2 5980.8 6013.6 6177.0 9322.7 9496.4 9516.2 9612.2 9684.9 7770.3 9334.9 9770.0 9803.9 9948.3 6820.6 7046.9 7264.5 7533.7 7603.3 8214.9 8239.8 8274.9 8304.2 8311.8 7235.7 7332.5 7360.1 7489.4 7498.1 7166.2 7336.0 7386.9 7415.9 7430.5 7008.4 7089.5 7107.4 7108.4 7113.9 4879.3 4910.3 4944.5 5041.7 5044.4 4985.1 5004.7 5060.0 5150.1 5316.5 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#4] prototype.html Cycles:180 Average:5889.76 Median:6754.32 stddev:1894.73 (28.1%) stddev-sans-first:1853.49 03:41:09 INFO - PROCESS | 1948 | Values: 328.4 330.9 338.8 342.2 344.2 6729.1 6730.5 6751.3 6780.4 6795.6 6651.5 6691.7 6757.4 6774.0 6778.7 4681.6 4847.7 4877.1 4888.3 4891.3 4759.9 4857.3 4908.5 4926.8 4998.0 4826.3 4882.8 4898.1 4907.5 4917.1 4009.2 4778.5 4902.8 4918.2 4918.6 4013.3 4080.0 4164.3 4186.7 4214.0 6471.2 6489.9 6498.3 6498.4 6532.9 4742.4 5862.1 5871.4 5877.1 5884.7 5797.6 6062.8 7134.8 7136.0 7156.0 4577.3 4721.0 4729.6 4729.9 4742.2 6102.0 7592.3 7608.3 7610.2 7618.7 4841.3 4875.4 4884.2 4885.3 4887.0 4430.4 4696.3 4984.2 4985.6 4995.9 4728.7 5887.3 5912.3 5915.6 5916.7 7009.4 7172.7 7222.7 7233.2 7236.0 1473.6 1698.1 1702.5 1721.9 1724.0 1098.5 1099.2 1114.6 1117.3 1120.0 6667.8 6850.6 6904.2 6921.2 6923.5 7294.7 7429.0 7442.2 7448.8 7453.0 5659.0 6948.8 6958.4 6959.4 6963.5 3924.3 3983.7 3986.6 3987.9 3996.6 7664.6 7904.8 7917.6 7935.6 7944.5 7689.2 7719.7 7736.7 7737.6 7748.0 6687.9 7595.1 7858.8 7871.7 7903.3 7457.3 7473.9 7479.1 7490.0 7494.4 7073.5 7330.3 7338.7 7340.8 7362.9 7805.5 7838.8 7859.1 7871.1 7946.9 4237.8 4884.9 4889.4 4893.8 4899.3 7465.8 7469.0 7472.4 7473.0 7492.2 6933.2 7222.4 7224.0 7230.5 7266.0 7138.2 7181.1 7187.4 7194.0 7208.3 7059.3 7064.7 7065.0 7073.6 7075.5 6986.0 7199.3 7235.0 7235.1 7249.4 6774.2 7088.4 7092.6 7104.9 7115.1 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - PROCESS | 1948 | [#5] yui.html Cycles:180 Average:18567.40 Median:4400.87 stddev:25743.56 (585.0%) stddev-sans-first:25780.89 03:41:09 INFO - PROCESS | 1948 | Values: 718.6 759.6 771.4 784.0 807.0 15428.7 15430.9 15524.5 15611.3 15619.9 14671.5 14891.3 14891.7 14927.1 14953.3 796.6 809.1 955.8 958.8 985.7 975.1 994.1 994.6 995.4 998.4 1005.3 1020.2 1020.7 1020.8 1022.8 826.6 840.4 843.0 845.5 998.1 766.4 773.3 780.7 784.2 784.9 15940.5 16004.8 16021.4 16030.8 16108.3 13159.8 13175.3 13200.7 13475.7 13508.3 10235.6 10457.1 11138.3 11170.3 11567.8 3566.5 3614.8 3639.9 3642.6 3757.7 87056.0 88889.6 89271.0 89535.6 89955.0 9653.9 10132.4 10334.2 10405.4 10513.8 23486.3 23490.3 23494.0 23494.6 23531.2 7705.0 7706.8 7769.3 7889.2 8117.9 4251.7 4393.2 4400.1 4401.6 4588.7 3754.4 3814.8 3822.2 3826.6 3833.8 599.9 618.5 620.5 667.3 695.2 551.4 568.2 606.2 626.6 642.6 7964.7 8174.4 8279.6 8409.5 8468.8 485.8 578.6 604.5 607.4 629.8 3798.8 3945.4 3999.2 4104.8 4159.9 83860.2 85877.7 85902.0 85936.0 85989.1 79522.2 80844.2 80935.0 81771.0 82385.0 69523.3 71407.3 72109.0 73253.6 73773.0 7885.3 7912.4 8007.4 8113.3 8541.7 35758.0 47327.0 47980.0 48731.8 49336.3 45283.5 60270.4 70385.6 71050.6 71963.6 11246.7 11316.3 11399.4 11530.9 12186.7 11983.3 12013.8 12268.8 12280.3 12901.5 11798.8 11830.7 11858.2 11926.9 12038.8 11700.7 11793.8 11796.2 11803.9 11930.9 11501.8 11707.2 11793.9 11848.1 12074.7 10146.0 10228.7 10285.0 10440.4 10468.8 9733.7 9998.0 10218.9 10238.8 10276.0 03:41:09 INFO - PROCESS | 1948 | -------- Summary: end -------- 03:41:09 INFO - PROCESS | 1948 | 03:41:09 INFO - TEST-INFO | 1948: exit 0 03:41:09 INFO - TEST-OK | dromaeo_css | took 1112767ms 03:41:09 INFO - TEST-START | kraken 03:41:09 INFO - operating with platform_type : mac_ 03:41:09 INFO - Initialising browser for kraken test... 03:41:09 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpRgmOcQ/profile http://localhost:52823/getInfo.html) 03:41:12 INFO - PROCESS | 1975 | __metrics Screen width/height:1600/1200 03:41:12 INFO - PROCESS | 1975 | colorDepth:24 03:41:12 INFO - PROCESS | 1975 | Browser inner width/height: 1024/689 03:41:12 INFO - PROCESS | 1975 | __metrics 03:41:12 INFO - PROCESS | 1975 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:12 ERROR - PROCESS | 1975 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:12 INFO - TEST-INFO | 1975: exit 0 03:41:12 INFO - Browser initialized. 03:41:12 INFO - Running cycle 1/1 for kraken test... 03:41:12 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpRgmOcQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:24 INFO - PROCESS | 1978 | RSS: Main: 161193984 03:41:24 INFO - PROCESS | 1978 | 03:41:27 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52823/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:28 INFO - PROCESS | 1978 | RSS: Main: 224305152 03:41:28 INFO - PROCESS | 1978 | 03:41:30 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52823/tests/kraken/driver.html?testName=audio-dft) 03:41:31 INFO - PROCESS | 1978 | RSS: Main: 239517696 03:41:31 INFO - PROCESS | 1978 | 03:41:34 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52823/tests/kraken/driver.html?testName=audio-fft) 03:41:35 INFO - PROCESS | 1978 | RSS: Main: 323878912 03:41:35 INFO - PROCESS | 1978 | 03:41:37 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52823/tests/kraken/driver.html?testName=audio-oscillator) 03:41:37 INFO - PROCESS | 1978 | RSS: Main: 230588416 03:41:37 INFO - PROCESS | 1978 | 03:41:39 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:40 INFO - PROCESS | 1978 | RSS: Main: 232296448 03:41:40 INFO - PROCESS | 1978 | 03:41:43 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52823/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:43 INFO - PROCESS | 1978 | RSS: Main: 271151104 03:41:43 INFO - PROCESS | 1978 | 03:41:46 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52823/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:47 INFO - PROCESS | 1978 | RSS: Main: 270749696 03:41:47 INFO - PROCESS | 1978 | 03:41:50 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52823/tests/kraken/driver.html?testName=json-parse-financial) 03:41:50 INFO - PROCESS | 1978 | RSS: Main: 269332480 03:41:50 INFO - PROCESS | 1978 | 03:41:52 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:53 INFO - PROCESS | 1978 | RSS: Main: 260620288 03:41:53 INFO - PROCESS | 1978 | 03:41:54 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:55 INFO - PROCESS | 1978 | RSS: Main: 268857344 03:41:55 INFO - PROCESS | 1978 | 03:41:57 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:58 INFO - PROCESS | 1978 | RSS: Main: 271065088 03:41:58 INFO - PROCESS | 1978 | 03:42:00 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:01 INFO - PROCESS | 1978 | RSS: Main: 278003712 03:42:01 INFO - PROCESS | 1978 | 03:42:04 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:04 INFO - PROCESS | 1978 | RSS: Main: 275267584 03:42:04 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:52823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52823/tests/kraken/driver.html?testName=ai-astar) 03:42:06 INFO - PROCESS | 1978 | RSS: Main: 336416768 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | __start_tp_report 03:42:06 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 03:42:06 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 03:42:06 INFO - PROCESS | 1978 | |i|pagename|runs| 03:42:06 INFO - PROCESS | 1978 | |0;ai-astar;110;112;117;111;110;111;111;111;111;135 03:42:06 INFO - PROCESS | 1978 | |1;audio-beat-detection;157;123;141;162;120;139;139;119;167;115 03:42:06 INFO - PROCESS | 1978 | |2;audio-dft;184;185;183;183;184;180;216;265;183;182 03:42:06 INFO - PROCESS | 1978 | |3;audio-fft;64;73;74;154;55;56;56;61;131;57 03:42:06 INFO - PROCESS | 1978 | |4;audio-oscillator;89;90;144;79;79;85;125;79;80;122 03:42:06 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;90;87;90;87;90;87;90;88;90;86 03:42:06 INFO - PROCESS | 1978 | |6;imaging-darkroom;93;101;94;94;93;93;94;94;94;94 03:42:06 INFO - PROCESS | 1978 | |7;imaging-desaturate;127;135;138;85;83;83;84;82;84;85 03:42:06 INFO - PROCESS | 1978 | |8;json-parse-financial;59;63;64;59;62;62;66;79;59;56 03:42:06 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;61;65;68;72;75;69;68;66;65;64 03:42:06 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;81;78;80;80;79;78;78;78;80;83 03:42:06 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;143;142;128;126;126;128;136;143;132;127 03:42:06 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;167;165;162;172;163;163;157;162;160;161 03:42:06 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;65;66;68;66;66;67;67;68;66;66 03:42:06 INFO - PROCESS | 1978 | __end_tp_report 03:42:06 INFO - PROCESS | 1978 | __start_cc_report 03:42:06 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,1894 03:42:06 INFO - PROCESS | 1978 | __end_cc_report 03:42:06 INFO - PROCESS | 1978 | __startTimestamp1467974526839__endTimestamp 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | ------- Summary: start ------- 03:42:06 INFO - PROCESS | 1978 | Number of tests: 14 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:113.90 Median:111.00 stddev:7.68 (6.9%) stddev-sans-first:8.02 03:42:06 INFO - PROCESS | 1978 | Values: 110.0 112.0 117.0 111.0 110.0 111.0 111.0 111.0 111.0 135.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:140.00 stddev:18.94 (13.5%) stddev-sans-first:18.82 03:42:06 INFO - PROCESS | 1978 | Values: 157.0 123.0 141.0 162.0 120.0 139.0 139.0 119.0 167.0 115.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:194.50 Median:184.00 stddev:26.89 (14.6%) stddev-sans-first:28.25 03:42:06 INFO - PROCESS | 1978 | Values: 184.0 185.0 183.0 183.0 184.0 180.0 216.0 265.0 183.0 182.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:78.10 Median:59.00 stddev:35.04 (59.4%) stddev-sans-first:36.79 03:42:06 INFO - PROCESS | 1978 | Values: 64.0 73.0 74.0 154.0 55.0 56.0 56.0 61.0 131.0 57.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.50 stddev:23.89 (30.0%) stddev-sans-first:25.15 03:42:06 INFO - PROCESS | 1978 | Values: 89.0 90.0 144.0 79.0 79.0 85.0 125.0 79.0 80.0 122.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:90.00 stddev:1.65 (1.8%) stddev-sans-first:1.66 03:42:06 INFO - PROCESS | 1978 | Values: 90.0 87.0 90.0 87.0 90.0 87.0 90.0 88.0 90.0 86.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:2.37 (2.5%) stddev-sans-first:2.46 03:42:06 INFO - PROCESS | 1978 | Values: 93.0 101.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:83.50 stddev:24.13 (28.9%) stddev-sans-first:23.31 03:42:06 INFO - PROCESS | 1978 | Values: 127.0 135.0 138.0 85.0 83.0 83.0 84.0 82.0 84.0 85.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.50 stddev:6.37 (10.2%) stddev-sans-first:6.60 03:42:06 INFO - PROCESS | 1978 | Values: 59.0 63.0 64.0 59.0 62.0 62.0 66.0 79.0 59.0 56.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:68.00 stddev:4.06 (6.0%) stddev-sans-first:3.61 03:42:06 INFO - PROCESS | 1978 | Values: 61.0 65.0 68.0 72.0 75.0 69.0 68.0 66.0 65.0 64.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:1.65 (2.1%) stddev-sans-first:1.66 03:42:06 INFO - PROCESS | 1978 | Values: 81.0 78.0 80.0 80.0 79.0 78.0 78.0 78.0 80.0 83.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:134.00 stddev:7.26 (5.4%) stddev-sans-first:6.76 03:42:06 INFO - PROCESS | 1978 | Values: 143.0 142.0 128.0 126.0 126.0 128.0 136.0 143.0 132.0 127.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:4.10 (2.5%) stddev-sans-first:4.12 03:42:06 INFO - PROCESS | 1978 | Values: 167.0 165.0 162.0 172.0 163.0 163.0 157.0 162.0 160.0 161.0 03:42:06 INFO - PROCESS | 1978 | 03:42:06 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:0.87 03:42:06 INFO - PROCESS | 1978 | Values: 65.0 66.0 68.0 66.0 66.0 67.0 67.0 68.0 66.0 66.0 03:42:06 INFO - PROCESS | 1978 | -------- Summary: end -------- 03:42:06 INFO - PROCESS | 1978 | 03:42:07 INFO - TEST-INFO | 1978: exit 0 03:42:07 INFO - TEST-OK | kraken | took 57629ms 03:42:07 INFO - SUITE-END | took 1170s 03:42:07 INFO - Completed test suite (00:19:30) 03:42:08 INFO - javascript benchmark 03:42:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3473.6526347365257, 3585.1216451969262, 3587.1390866192123, 3602.513660655812, 3648.197396572753, 5822.515977928629, 5825.30096388433, 5859.824205273849, 5891.675957822324, 5919.0, 5835.328937172216, 5886.970565147169, 5911.556633252501, 5911.9408805912035, 5920.259967504062, 5252.290940722992, 5268.0, 5289.471052894699, 5331.040412725708, 5369.328833895763, 5272.420033796279, 5336.092864213093, 5338.359396872381, 5343.251944727741, 5349.22436246744, 5268.367795864501, 5327.733613319338, 5332.733363331818, 5361.061814182522, 5362.865928351803, 5315.36215654122, 5330.28041214435, 5339.466053394668, 5348.358197016344, 5368.865778355534, 5144.897102057976, 5202.297689811865, 5274.208868669692, 5282.075636763551, 5292.523672869422, 4263.4031235627035, 5731.312242530923, 5735.971320143414, 5771.826845194651, 5775.220345253421, 6316.957701979214, 6333.87332253357, 6337.176167098294, 6338.144350512668, 6338.6196828189995, 5179.792808287664, 6143.911070236097, 6284.277308109535, 6291.245050593912, 6338.841528961767, 5852.619579727347, 5895.263092113486, 5908.645481271137, 5908.67502287374, 5912.674802885796, 6408.871822563523, 6411.070394792729, 6415.518836087219, 6419.293877673452, 6426.35736426363, 6126.456603435116, 6180.752769889244, 6258.186435763321, 6265.404786545271, 6290.528210384239, 6280.026595877646, 6312.274088479791, 6324.557280990287, 6331.145295385156, 6339.080833279241, 6289.465395441347, 6315.052742088632, 6331.303556608769, 6344.302126766052, 6363.9045414318825, 6180.443760061616, 6273.404026617464, 6289.937100629027, 6290.0, 6322.652254125976, 4229.407882896397, 4990.650654454226, 5043.470435604208, 5045.672031318026, 5056.646034777604, 4484.439445069366, 4484.955150448519, 4500.279955207151, 4506.414166158378, 4543.954560454419, 5969.462748352669, 6044.063170208625, 6052.455279024909, 6095.847603809941, 6103.450689437883, 6233.3143354231, 6287.182666253358, 6302.873942521124, 6319.146915166394, 6322.71547780351, 5038.974805125951, 6066.998945174085, 6069.666168360694, 6081.422264884829, 6095.207623009069, 5445.156000819879, 5471.37079235885, 5483.698396588146, 5521.0, 5534.418886016911, 6485.77299794505, 6582.440492558187, 6583.967080164569, 6588.934110658832, 6591.242007169237, 6290.842728931813, 6298.433141017331, 6314.463270622048, 6315.96842015787, 6335.65153916539, 6407.359264073555, 6450.645214513247, 6580.144581204413, 6589.0116482528, 6617.7683781067435, 6270.498360131087, 6282.246130464374, 6318.589291696025, 6327.525435592441, 6329.810105696836, 5202.73986300691, 5238.214267859851, 6244.157038799885, 6286.339934306832, 6289.245290564979, 6106.794380079809, 6191.845203869759, 6257.624542527463, 6257.812265632038, 6275.058741188858, 6158.661273629814, 6221.720022599085, 6222.066689996536, 6223.253209614875, 6226.066090086523, 5100.770465328995, 5964.582479226413, 6115.4190351916495, 6142.662153581596, 6145.72344244519, 6109.572329937039, 6126.884121540821, 6233.75064997395, 6248.562600617913, 6274.215723034621, 6144.17053697763, 6164.321924588381, 6166.537509686702, 6174.073888916699, 6181.474574661024], "value": 5793.665699814932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.1607659897362, 547.2693953571982, 578.943404752043, 588.5203559099331, 593.3265743381262, 33295.0, 33935.15162120948, 41343.17313653729, 41345.37981930273, 41402.0, 44466.555334446646, 44943.77528112363, 45044.0, 45047.0990580189, 45067.77466112665, 9218.446893186398, 9745.463999480044, 9949.0, 9961.203103751683, 11904.7619047619, 11892.989095926856, 12013.939930300336, 12015.519379224821, 12019.338936358497, 12021.278723276631, 11957.0, 12017.699557511089, 12034.939825300862, 12043.518259269662, 12050.276983380982, 11900.583479578216, 11930.701732456671, 12004.219725717887, 12021.699457513545, 12036.81944770829, 11849.703757406047, 11974.461149248305, 11979.700507487383, 12205.962493188, 12232.633021009384, 43226.0, 43532.56467435317, 43674.56325436737, 43697.563024369665, 43734.0, 3313.8177400242976, 3487.9651203488147, 3647.361711700442, 3705.6479634434686, 3959.5248570171475, 27383.86308068447, 29698.70301296981, 30210.395792084255, 30814.69185308163, 30840.228994275098, 2750.7386798254333, 2775.9028434004713, 2821.661400631917, 2834.008097165996, 2872.8563571821323, 504391.9560804418, 506205.0, 506516.0, 507531.0, 509755.0, 38179.85460436191, 38657.42013869794, 38710.0, 68909.2772680687, 69494.65252673805, 37381.813090934374, 37623.435648465296, 37639.4354084689, 37733.24533509315, 37733.43399849004, 15625.296861641253, 15808.920955395379, 16496.17519124039, 16691.99848009123, 16693.582660433585, 12518.561850335194, 13199.736005280032, 13410.932945335211, 14217.64455888611, 14257.21585312797, 7795.649195786204, 8189.0, 8539.701110461105, 8565.400421970528, 8705.216530512283, 3578.302231064917, 3596.2447885944243, 3604.3151801157696, 3621.583517895476, 3636.927261454809, 818.4639061414783, 1039.0181278691564, 1071.4696225368493, 1086.7554800169898, 1133.0822034152363, 31105.377892442026, 31428.842855785573, 31450.37099258048, 31583.733467905073, 31681.366372672877, 1057.0275346681071, 1109.8501702270253, 1215.9878401216051, 1231.7228623559806, 1296.9805452918213, 16209.675806483805, 16228.83771162297, 16229.91885040591, 16339.918300408659, 16354.427595034354, 556877.0, 562840.0, 563206.0, 563957.1802140963, 564182.0, 65501.0, 66284.33715662878, 66345.66827165833, 66379.0, 66382.0, 1423.7650787620134, 1587.952361429159, 1608.0, 1625.5610985033975, 1673.4226691791312, 24363.878180608983, 29497.820087196273, 29896.402071958873, 30362.392752145275, 31327.530087048257, 52607.68480788011, 52935.73532132315, 53048.73475632597, 53065.0, 53117.7344113277, 416837.0, 425718.0, 426357.8682106694, 427644.0, 428301.0, 25115.623265651397, 28132.71867281383, 28803.70383332713, 28950.42099158047, 29177.270568235963, 44656.553434466536, 45831.54168458406, 46247.53752462432, 46384.768076160755, 46732.0, 35200.47199292064, 35938.0, 36811.26377472489, 37379.81310093432, 37625.24749505049, 33907.0, 35431.82284088563, 38246.0, 38720.41919371268, 39204.66116638473, 38148.80925595354, 38478.0, 38560.80719596496, 38831.2233755329, 39156.80421597988, 27020.864895675397, 32805.507917381736, 33581.83209083939, 33660.158496037795, 33875.4918676225, 25505.0, 25507.74492255128, 25546.489070218864, 25590.0, 26121.955121795676], "value": 19414.821042458243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.40882537970697, 414.0952019836656, 414.92946199146144, 417.30935302075056, 426.96584273258145, 20629.27797527087, 21274.36176914693, 21303.893480532595, 21806.236781712643, 22811.885940570315, 12609.865112139905, 12610.495580176805, 12625.431855566498, 15637.452689155882, 21576.784232157675, 5276.393214780311, 5407.945920540803, 5545.0, 5576.944230557703, 5577.637453565505, 6029.035354343306, 6093.969530152343, 6127.662978536178, 6139.662318572477, 6164.630122192661, 5904.3800400957925, 6162.599431036991, 6167.537434692416, 6168.660723660197, 6179.165812615307, 6067.908981365283, 6091.51267898567, 6125.356837532062, 6126.7549298028025, 6130.172426722403, 5721.342045664718, 5898.528117750569, 5924.140999555084, 6084.878302433971, 6094.481969032638, 26258.474830503284, 26344.814483348295, 26579.601305980425, 26775.598366024526, 26801.597976030374, 2082.37528741377, 2157.331227319536, 2223.3663405929233, 2776.0977682253147, 2834.7590454811366, 9202.263818894473, 9720.951395242979, 9885.406875587487, 10239.822420421673, 10409.479526023744, 1805.1024096087278, 1824.6898027335253, 1867.738516607676, 1868.1126464929187, 1883.6421079994893, 69757.2560685987, 102916.48541757319, 105297.0, 115356.69286614221, 122549.0, 9905.306628535933, 12000.939995300143, 12035.819462708067, 12039.097067719957, 12057.939710301393, 14199.36102875373, 14581.927090364481, 14584.854151458561, 14860.851391485947, 15353.002054866622, 9028.0, 9062.50156241413, 9227.077292270718, 9232.446053236827, 9324.90675093254, 9232.21526170283, 9235.353525253302, 9260.351775375793, 9319.953400233091, 9379.718608441757, 3918.275119102975, 4138.710290279651, 4622.537746225351, 4745.738984355825, 4794.352762377104, 1721.5007647782254, 2002.2691717522998, 2013.7784843667184, 2047.1708957872086, 2069.2136987944486, 916.9312301577409, 995.9701208963743, 1034.6533911139702, 1070.106461104986, 1099.7580532282884, 19690.40928772139, 20539.28112516055, 20544.691829622567, 20888.47778805542, 20893.582128357346, 897.717219075989, 983.5279066048193, 992.1021475564626, 998.3710262534556, 1034.9223808214415, 10714.46427678613, 11197.16021298406, 11237.044851187577, 11246.831297530543, 11274.436278186058, 614110.0, 614829.0, 617807.0, 628940.0, 660501.0, 101328.0, 110715.0, 113629.0, 123153.0, 124414.0, 1052.1162223732101, 1063.0857462582173, 1077.9514921828536, 1078.8489611454402, 1084.1218612923558, 18079.45761627153, 18217.908910455364, 18396.0, 18586.721199181753, 18964.620707586048, 46639.76680116577, 46878.76560617175, 49347.25979110388, 49410.752946235036, 50895.982080358925, 66339.0, 68576.62846743136, 69802.65098674475, 70509.64745176242, 70902.29097709163, 8277.0, 8339.95830020846, 8415.789605259917, 8459.280961118375, 8771.16673915977, 8047.034355877332, 9359.0, 12817.359132043173, 13052.34738263064, 13250.072494925264, 11207.374930634849, 11314.151438642299, 11375.1468639854, 11565.884341156481, 11729.061675065803, 9160.496172710566, 9221.182556246687, 11304.49129789145, 11396.2592431495, 11461.968422841985, 11270.661880143609, 11581.189316747746, 11581.768364632828, 11596.0, 11771.117166212398, 7203.351698347174, 8302.460340077876, 8324.25081742646, 8331.791705207419, 8420.284275836622, 10384.792304153723, 11382.203245772716, 11491.482883270106, 11566.421678915853, 11697.2981621103], "value": 9573.659250412074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.0144799364446, 1604.7352186889161, 1623.9188040597974, 1883.585611165544, 1991.502124468882, 6995.230524642286, 8687.913120868789, 8835.558222088886, 8850.822983540325, 8876.33427492939, 8481.491110533358, 8561.91438085619, 8723.694670686527, 8740.43187192832, 8751.081136480674, 2477.6902887139154, 2504.2362079565723, 2507.2227609441043, 2509.2472258322523, 2510.949781004388, 2437.025189924027, 2495.25142457263, 2497.5379554782335, 2503.324102492326, 2505.4863752930696, 2085.4786303424144, 2411.770881766229, 2502.687164104487, 2506.310764539757, 2508.2600632813273, 2452.6934133233344, 2487.56467618167, 2489.9004039838474, 2502.336880726609, 2507.761762632547, 2447.167962892625, 2479.7148327942336, 2491.364702000996, 2496.2636022373445, 2504.749525047499, 8530.658773649047, 8727.345449091343, 8778.736637900873, 8781.824363512758, 8793.076726943642, 5285.207218917155, 5437.966786310589, 5445.0, 5480.013597552439, 5503.3395992480755, 3507.94738078929, 3548.6806187442994, 3559.519464872261, 3614.8734794282072, 3635.4910312556, 907.3512438606363, 943.9952800236024, 1051.7002654243504, 1087.2986923434419, 1097.7091070866227, 11459.0, 11559.422028898522, 11716.999999999915, 11723.472443739967, 11734.354610496419, 4579.564941330568, 4652.092841895797, 4737.360456338419, 4744.857654270378, 4757.9286310705365, 7504.474686771873, 9072.81854362909, 9198.586063627154, 9203.309751768644, 9206.0, 5241.50205730455, 5296.311479507639, 5302.708351040653, 5306.54894333986, 5322.787088516416, 3672.7061835053664, 4563.680542362003, 4820.783064762024, 4896.951030489649, 4993.575546078551, 3831.3869780834934, 3879.8836034919, 3945.9605403945593, 3948.9930067833093, 3974.503187101612, 1202.6788298583817, 1203.1457665057908, 1204.560335477562, 1210.5581462766027, 1221.8717034711406, 902.7923577577062, 953.2326477185932, 964.1563631822156, 979.299800642544, 1014.3153371474225, 5511.421300763443, 5861.263132664842, 5910.231669882888, 5992.280926288786, 6073.6659483727935, 481.54734549523334, 485.3738677106493, 494.6067876038558, 496.6275293529853, 502.3544745002654, 3934.4885164928946, 3965.1871366369824, 4039.8788036358956, 4103.2409004334295, 4107.486564179478, 10343.224258180666, 10855.40295283767, 10888.727781805519, 10895.727606809734, 10899.400532970763, 8366.330693544502, 9961.35251208669, 10425.530851111718, 10673.41296228715, 10679.466026698634, 8122.55325957078, 8319.043310019426, 8323.83352332962, 8354.58227088643, 8372.246497815226, 5636.718164091861, 5873.177755114373, 5980.820575382745, 6013.609115407659, 6176.980798168252, 9322.673706420243, 9496.43021418717, 9516.238700903772, 9612.1829644481, 9684.903150968681, 7770.339521140766, 9334.859977100214, 9770.0, 9803.901960980298, 9948.303618746619, 6820.62486563224, 7046.859062818818, 7264.491485596169, 7533.698652053857, 7603.2776886195725, 8214.876776848472, 8239.835203295781, 8274.917250827655, 8304.169583041648, 8311.792205194919, 7235.674394652358, 7332.523385979895, 7360.116785985502, 7489.363404110712, 7498.137714162941, 7166.162483847104, 7335.9729637851815, 7386.926130738624, 7415.888761668687, 7430.517016393917, 7008.439324853897, 7089.539179953286, 7107.431405487445, 7108.360247577536, 7113.928860711327, 4879.292502587034, 4910.337104490991, 4944.456109827988, 5041.722705251246, 5044.4198917125, 4985.1276026695905, 5004.674696144884, 5059.974700126623, 5150.072986862401, 5316.548093412103], "value": 4505.239022648278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.4498465071006, 330.85029522409627, 338.80349397349534, 342.17706416069365, 344.2289272030652, 6729.0915726376925, 6730.519285757138, 6751.25736169021, 6780.35586619271, 6795.626240556768, 6651.4678825693945, 6691.698873550689, 6757.391834734885, 6774.0, 6778.661066946657, 4681.648876334271, 4847.709137451764, 4877.097736918681, 4888.340074090006, 4891.290762839386, 4759.85720428386, 4857.29569212464, 4908.460069392364, 4926.753662316888, 4998.0, 4826.3001864729595, 4882.829100981467, 4898.093852637274, 4907.460179380265, 4917.139500587401, 4009.1981603679087, 4778.474367819537, 4902.754862256891, 4918.2376731606655, 4918.557329840296, 4013.2776100301935, 4079.9592004079877, 4164.312888373414, 4186.748795072275, 4213.9578604214175, 6471.191101112361, 6489.870202595922, 6498.252700939405, 6498.415142637185, 6532.902006469907, 4742.383490146259, 5862.091375836752, 5871.412858714137, 5877.147813567051, 5884.6763428011445, 5797.594168408213, 6062.848428789272, 7134.785956421316, 7135.964320178417, 7156.0, 4577.29051996941, 4720.952790472085, 4729.59798417135, 4729.929051064237, 4742.241241401393, 6101.969490152521, 7592.316691497736, 7608.277213664693, 7610.1628820829665, 7618.695252189906, 4841.346418233564, 4875.390576177978, 4884.169691152512, 4885.316055752198, 4886.95113048865, 4430.379746835446, 4696.342512048316, 4984.177610694267, 4985.576226020757, 4995.850954280463, 4728.668993170445, 5887.264091988502, 5912.320083190488, 5915.64506129625, 5916.704164791743, 7009.410054417241, 7172.677229524684, 7222.674979625929, 7233.204347521769, 7236.0, 1473.5652982370011, 1698.1169791708242, 1702.4637239269591, 1721.8536424403815, 1723.9827601724073, 1098.4562641492512, 1099.1701265544464, 1114.6098865397207, 1117.3240189685123, 1120.0367683792094, 6667.766628167991, 6850.588964662136, 6904.240533541307, 6921.238663746984, 6923.480738944499, 7294.671739771723, 7429.0, 7442.21856705049, 7448.776536703907, 7453.031105956299, 5658.971705141448, 6948.791536253921, 6958.373746362851, 6959.4432445405255, 6963.547369421073, 3924.3132451820816, 3983.701222408331, 3986.5614782373914, 3987.92024159521, 3996.5603783583783, 7664.578448185292, 7904.802379940547, 7917.564533950688, 7935.64289606969, 7944.523328600187, 7689.154193038761, 7719.729809456642, 7736.690532378641, 7737.613119344011, 7748.0, 6687.899681504781, 7595.050618672666, 7858.764237072897, 7871.685132594746, 7903.288704016666, 7457.291557302047, 7473.850522989618, 7479.139898911477, 7490.0, 7494.437917156126, 7073.504854660125, 7330.340269375782, 7338.6697598607125, 7340.816479588053, 7362.926370736438, 7805.4536182468955, 7838.843223135391, 7859.135495095649, 7871.094824095073, 7946.92053079485, 4237.78811059452, 4884.902301954012, 4889.413270407574, 4893.804247830047, 4899.3385892904, 7465.813354666177, 7468.991686122304, 7472.439567032386, 7472.962635186789, 7492.175860655432, 6933.237343892269, 7222.386097181588, 7223.963880180566, 7230.45771567124, 7266.0, 7138.214796372291, 7181.102362204724, 7187.353138217585, 7194.028806111317, 7208.27917208275, 7059.2940705928995, 7064.682089306097, 7064.964675176591, 7073.610951397723, 7075.5047146699235, 6986.0, 7199.280071992759, 7235.023271858442, 7235.131784185932, 7249.383802376857, 6774.153230846145, 7088.397486213729, 7092.645367731489, 7104.893426598502, 7115.1106111736035], "value": 5258.971568741017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.5544962123485, 759.5632511306001, 771.3674786674928, 783.9686412543497, 806.9556174410405, 15428.69142617147, 15430.922845385772, 15524.534263972071, 15611.29749161289, 15619.921900390496, 14671.486497972573, 14891.25543722815, 14891.702165956674, 14927.104373737557, 14953.327100280487, 796.5738329993454, 809.0857331215718, 955.7610597350663, 958.8417911044669, 985.7437066362726, 975.0639386189231, 994.060612720979, 994.636957510507, 995.3828626251734, 998.4009594243432, 1005.3264312910368, 1020.2450186861706, 1020.6835880876915, 1020.7652239984808, 1022.8465730140464, 826.5908375354209, 840.4453060979724, 842.9957850210772, 845.5222799118478, 998.0817647764038, 766.3715753082474, 773.261535233856, 780.6955287437847, 784.1726978038167, 784.8587254294225, 15940.521784346372, 16004.75992860108, 16021.439249626206, 16030.83969160305, 16108.275127619285, 13159.802602960963, 13175.275359855204, 13200.6699832504, 13475.730485390237, 13508.257045862474, 10235.590576376935, 10457.111145552637, 11138.33170009802, 11170.273932194463, 11567.826482602768, 3566.5006899034156, 3614.7650402724003, 3639.945400818963, 3642.6357364263627, 3757.7181711371754, 87056.0, 88889.55555222247, 89271.0, 89535.55232223863, 89955.0, 9653.855192172123, 10132.442715650563, 10334.224933130045, 10405.42770147634, 10513.84229236562, 23486.295411137693, 23490.295291141294, 23494.0, 23494.64758028631, 23531.17640882561, 7705.0, 7706.807329816799, 7769.300762931363, 7889.17163697815, 8117.918820811717, 4251.659867210616, 4393.1872603568445, 4400.141972315432, 4401.603855653007, 4588.655850811202, 3754.4180651998986, 3814.790186539767, 3822.1591249924973, 3826.6364695353896, 3833.789141597239, 599.9040153575407, 618.5113760129448, 620.4571000374672, 667.3060017581757, 695.2074634916199, 551.3686828581332, 568.2186992884783, 606.2028432611103, 626.5770604841714, 642.6208536963214, 7964.685826838507, 8174.427790054758, 8279.62741676626, 8409.453385529921, 8468.830623387497, 485.8493866901272, 578.5805291163872, 604.5314880967286, 607.3531688751466, 629.8330942300294, 3798.8290526926353, 3945.447637330776, 3999.1601763629383, 4104.753714777123, 4159.854405095807, 83860.16139838523, 85877.71183432253, 85902.0, 85936.0, 85989.14010859812, 79522.20477795148, 80844.19155808484, 80935.0, 81771.0, 82385.0, 69523.3047669527, 71407.2859271411, 72109.0, 73253.63373183207, 73773.0, 7885.329746971572, 7912.406569507425, 8007.35941124697, 8113.310368618733, 8541.743747687578, 35758.0, 47327.0, 47980.04039919112, 48731.75634121807, 49336.25995610141, 45283.54716452925, 60270.39729602648, 70385.64807175931, 71050.57898842098, 71963.64018179875, 11246.66260012201, 11316.26444281119, 11399.430028498376, 11530.884691152982, 12186.695332616755, 11983.28100313984, 12013.81979270329, 12268.815967760669, 12280.263184208976, 12901.548445804352, 11798.823017654913, 11830.704232394259, 11858.16992810495, 11926.880731192578, 12038.75922481528, 11700.70748231301, 11793.823092653789, 11796.16153498897, 11803.940980295043, 11930.940345298219, 11501.769964600493, 11707.180497365443, 11793.941030295136, 11848.052155827341, 12074.698132546757, 10145.985401459795, 10228.693139205538, 10285.0, 10440.42577658236, 10468.790624187626, 9733.707988760349, 9997.950010249902, 10218.897811021794, 10238.846417303896, 10276.0], "value": 7146.010236844617, "unit": "score"}], "name": "dromaeo_css", "value": 7530.328362816075, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 117.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 135.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 141.0, 162.0, 120.0, 139.0, 139.0, 119.0, 167.0, 115.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 183.0, 184.0, 180.0, 216.0, 265.0, 183.0, 182.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 74.0, 154.0, 55.0, 56.0, 56.0, 61.0, 131.0, 57.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 144.0, 79.0, 79.0, 85.0, 125.0, 79.0, 80.0, 122.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 90.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 101.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 138.0, 85.0, 83.0, 83.0, 84.0, 82.0, 84.0, 85.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 64.0, 59.0, 62.0, 62.0, 66.0, 79.0, 59.0, 56.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 68.0, 72.0, 75.0, 69.0, 68.0, 66.0, 65.0, 64.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 80.0, 79.0, 78.0, 78.0, 78.0, 80.0, 83.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 128.0, 126.0, 126.0, 128.0, 136.0, 143.0, 132.0, 127.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 162.0, 172.0, 163.0, 163.0, 157.0, 162.0, 160.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 68.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1475.9, "alertThreshold": 2.0}]} 03:42:08 INFO - Return code: 0 03:42:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:42:08 ERROR - # TBPL SUCCESS # 03:42:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:08 INFO - 2016-07-08 03:42:08.132 screenresolution[1982:20465] starting screenresolution argv=screenresolution get 03:42:08 INFO - 2016-07-08 03:42:08.134 screenresolution[1982:20465] Display 0: 1600x1200x32@60 03:42:08 INFO - 2016-07-08 03:42:08.140 screenresolution[1983:20468] starting screenresolution argv=screenresolution list 03:42:08 INFO - Available Modes on Display 0 03:42:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:08 INFO - Intel Iris: 03:42:08 INFO - Chipset Model: Intel Iris 03:42:08 INFO - Type: GPU 03:42:08 INFO - Bus: Built-In 03:42:08 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:08 INFO - Vendor: Intel (0x8086) 03:42:08 INFO - Device ID: 0x0a2e 03:42:08 INFO - Revision ID: 0x0009 03:42:08 INFO - Displays: 03:42:08 INFO - Display: 03:42:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:08 INFO - Display Serial Number: 1600x1200 60 03:42:08 INFO - Main Display: Yes 03:42:08 INFO - Mirror: Off 03:42:08 INFO - Online: Yes 03:42:08 INFO - Rotation: Supported 03:42:08 INFO - Return code: 0 03:42:08 INFO - Running post-action listener: _resource_record_post_action 03:42:08 INFO - Running post-run listener: _resource_record_post_run 03:42:09 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 1134592; Write bytes: 495369216; Read time: 14; Write time: 1974 03:42:09 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193217024; Write bytes: 187950592; Read time: 17585; Write time: 367 03:42:09 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 1134592; Write bytes: 297674240; Read time: 14; Write time: 1572 03:42:09 INFO - Running post-run listener: _upload_blobber_files 03:42:09 INFO - Blob upload gear active. 03:42:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:09 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 03:42:09 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'] 03:42:09 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 03:42:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:11 INFO - (blobuploader) - INFO - Done attempting. 03:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:12 INFO - (blobuploader) - INFO - Done attempting. 03:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:12 INFO - Return code: 0 03:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e744ca31563a22a91178dc39d0ed02db1118b6d3034abab2defafc5fe189910b056162fa2c7bbf4abad715a350c799471ee12a4a472bc19bff5cd89e2a282a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d37afaadf13fe7f51af9f39fc161a54c03334d204e7e17d0f51fdc5a6ea96235ce88db50d5621afa3f0e51d41a70a41647419a1a5903e85349336b163be09f6"} 03:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:12 INFO - Contents: 03:42:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e744ca31563a22a91178dc39d0ed02db1118b6d3034abab2defafc5fe189910b056162fa2c7bbf4abad715a350c799471ee12a4a472bc19bff5cd89e2a282a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d37afaadf13fe7f51af9f39fc161a54c03334d204e7e17d0f51fdc5a6ea96235ce88db50d5621afa3f0e51d41a70a41647419a1a5903e85349336b163be09f6"} 03:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:12 INFO - Copying logs to upload dir... 03:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.324103 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-08 03:42:12.102734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:12.106149) ========= 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.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e744ca31563a22a91178dc39d0ed02db1118b6d3034abab2defafc5fe189910b056162fa2c7bbf4abad715a350c799471ee12a4a472bc19bff5cd89e2a282a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d37afaadf13fe7f51af9f39fc161a54c03334d204e7e17d0f51fdc5a6ea96235ce88db50d5621afa3f0e51d41a70a41647419a1a5903e85349336b163be09f6"} build_url:https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/asPWtut1QPWGsbccQVWm0Q/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e744ca31563a22a91178dc39d0ed02db1118b6d3034abab2defafc5fe189910b056162fa2c7bbf4abad715a350c799471ee12a4a472bc19bff5cd89e2a282a5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d37afaadf13fe7f51af9f39fc161a54c03334d204e7e17d0f51fdc5a6ea96235ce88db50d5621afa3f0e51d41a70a41647419a1a5903e85349336b163be09f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:12.139509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:12.139852) ========= 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.uyUG2ClkHW/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.yxMDErSJed/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 03:42:12.188409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:42:12.188730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 03:42:12.189076) ========= ========= Total master_lag: 0.17 =========