builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0065 starttime: 1461478775.74 results: success (0) buildid: 20160423222844 builduid: 51f228ff267a4947b06c230953386aaf revision: f47b31f50a9a82984640ff6e17a86239808c8e15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:35.735371) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:35.735755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:35.736023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:35.938906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:35.939171) ========= 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.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-23 23:19:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.9M=0s 2016-04-23 23:19:36 (28.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118057 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:36.098201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:36.098518) ========= 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.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.027835 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:36.225259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:19:36.228458) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f47b31f50a9a82984640ff6e17a86239808c8e15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f47b31f50a9a82984640ff6e17a86239808c8e15 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-23 23:19:36,313 truncating revision to first 12 chars 2016-04-23 23:19:36,314 Setting DEBUG logging. 2016-04-23 23:19:36,314 attempt 1/10 2016-04-23 23:19:36,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f47b31f50a9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 23:19:37,486 unpacking tar archive at: fx-team-f47b31f50a9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.421696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 23:19:37.673775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:37.674051) ========= script_repo_revision: f47b31f50a9a82984640ff6e17a86239808c8e15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:37.677427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:37.677698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 23:19:37.698051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-23 23:19:37.698318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:19:37 INFO - MultiFileLogger online at 20160423 23:19:37 in /builds/slave/test 23:19:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:19:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:19:37 INFO - {'append_to_log': False, 23:19:37 INFO - 'base_work_dir': '/builds/slave/test', 23:19:37 INFO - 'blob_upload_branch': 'Fx-Team', 23:19:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:19:37 INFO - 'branch': 'Fx-Team', 23:19:37 INFO - 'buildbot_json_path': 'buildprops.json', 23:19:37 INFO - 'config_files': ('talos/mac_config.py',), 23:19:37 INFO - 'default_actions': ('clobber', 23:19:37 INFO - 'read-buildbot-config', 23:19:37 INFO - 'download-and-extract', 23:19:37 INFO - 'populate-webroot', 23:19:37 INFO - 'create-virtualenv', 23:19:37 INFO - 'install', 23:19:37 INFO - 'run-tests'), 23:19:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:19:37 INFO - 'download_minidump_stackwalk': True, 23:19:37 INFO - 'download_symbols': 'ondemand', 23:19:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:19:37 INFO - 'tooltool.py': '/tools/tooltool.py', 23:19:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:19:37 INFO - '/tools/misc-python/virtualenv.py')}, 23:19:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:19:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:19:37 INFO - 'installer_path': 'installer.exe', 23:19:37 INFO - 'log_level': 'info', 23:19:37 INFO - 'log_name': 'talos', 23:19:37 INFO - 'log_to_console': True, 23:19:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:19:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:19:37 INFO - 'opt_config_files': (), 23:19:37 INFO - 'pip_index': False, 23:19:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:19:37 INFO - 'cmd': ('bash', 23:19:37 INFO - '-c', 23:19:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:19:37 INFO - 'enabled': True, 23:19:37 INFO - 'halt_on_failure': False, 23:19:37 INFO - 'name': 'check_screen_resolution'},), 23:19:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:19:37 INFO - 'cmd': ('bash', 23:19:37 INFO - '-c', 23:19:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:19:37 INFO - 'enabled': True, 23:19:37 INFO - 'halt_on_failure': False, 23:19:37 INFO - 'name': 'check_screen_resolution'},), 23:19:37 INFO - 'run_cmd_checks_enabled': True, 23:19:37 INFO - 'sps_profile': False, 23:19:37 INFO - 'sps_profile_interval': 0, 23:19:37 INFO - 'suite': 'dromaeojs', 23:19:37 INFO - 'system_bits': '32', 23:19:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:19:37 INFO - 'title': 't-yosemite-r7-0065', 23:19:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:19:37 INFO - 'use_talos_json': True, 23:19:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:19:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:19:37 INFO - 'work_dir': 'build'} 23:19:37 INFO - ##### 23:19:37 INFO - ##### Running clobber step. 23:19:37 INFO - ##### 23:19:37 INFO - Running pre-action listener: _resource_record_pre_action 23:19:37 INFO - Running main action method: clobber 23:19:37 INFO - rmtree: /builds/slave/test/build 23:19:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:19:39 INFO - Running post-action listener: _resource_record_post_action 23:19:39 INFO - ##### 23:19:39 INFO - ##### Running read-buildbot-config step. 23:19:39 INFO - ##### 23:19:39 INFO - Running pre-action listener: _resource_record_pre_action 23:19:39 INFO - Running main action method: read_buildbot_config 23:19:39 INFO - Using buildbot properties: 23:19:39 INFO - { 23:19:39 INFO - "project": "", 23:19:39 INFO - "product": "firefox", 23:19:39 INFO - "script_repo_revision": "production", 23:19:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 23:19:39 INFO - "repository": "", 23:19:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 23:19:39 INFO - "buildid": "20160423222844", 23:19:39 INFO - "pgo_build": "False", 23:19:39 INFO - "basedir": "/builds/slave/test", 23:19:39 INFO - "buildnumber": 763, 23:19:39 INFO - "slavename": "t-yosemite-r7-0065", 23:19:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:19:39 INFO - "platform": "yosemite_r7", 23:19:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:19:39 INFO - "branch": "fx-team", 23:19:39 INFO - "repo_path": "integration/fx-team", 23:19:39 INFO - "revision": "f47b31f50a9a82984640ff6e17a86239808c8e15", 23:19:39 INFO - "stage_platform": "macosx64", 23:19:39 INFO - "builduid": "51f228ff267a4947b06c230953386aaf", 23:19:39 INFO - "slavebuilddir": "test" 23:19:39 INFO - } 23:19:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 23:19:39 INFO - Running post-action listener: _resource_record_post_action 23:19:39 INFO - ##### 23:19:39 INFO - ##### Running download-and-extract step. 23:19:39 INFO - ##### 23:19:39 INFO - Running pre-action listener: _resource_record_pre_action 23:19:39 INFO - Running main action method: download_and_extract 23:19:39 INFO - mkdir: /builds/slave/test/build/tests 23:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:39 INFO - https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:19:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:19:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 23:19:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 23:19:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 23:19:48 INFO - Downloaded 1199 bytes. 23:19:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 23:19:48 INFO - Using the following test package requirements: 23:19:48 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:19:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 23:19:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 23:19:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'jsshell-mac.zip'], 23:19:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 23:19:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 23:19:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 23:19:48 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 23:19:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 23:19:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 23:19:48 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 23:19:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:19:48 INFO - https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:19:50 INFO - Downloaded 18109576 bytes. 23:19:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:19:54 INFO - Return code: 0 23:19:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:19:54 INFO - https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 23:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:19:59 INFO - Downloaded 18109576 bytes. 23:19:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:19:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:20:02 INFO - Return code: 0 23:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:02 INFO - https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:20:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:20:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:20:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 23:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:20:03 INFO - Downloaded 10840145 bytes. 23:20:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:20:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:20:04 INFO - Return code: 0 23:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:04 INFO - https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:20:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:20:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:20:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 23:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 23:20:07 INFO - Downloaded 110119858 bytes. 23:20:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:20:07 INFO - mkdir: /builds/slave/test/properties 23:20:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:20:07 INFO - Writing to file /builds/slave/test/properties/build_url 23:20:07 INFO - Contents: 23:20:07 INFO - build_url:https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 23:20:07 INFO - Running post-action listener: _resource_record_post_action 23:20:07 INFO - Running post-action listener: set_extra_try_arguments 23:20:07 INFO - ##### 23:20:07 INFO - ##### Running populate-webroot step. 23:20:07 INFO - ##### 23:20:07 INFO - Running pre-action listener: _resource_record_pre_action 23:20:07 INFO - Running main action method: populate_webroot 23:20:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:20:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:20:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:20:07 INFO - '--tppagecycles', 23:20:07 INFO - '7'], 23:20:07 INFO - 'tests': ['tsvgm']}}, 23:20:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:20:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:20:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:20:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:20:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:20:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['damp', 'tps']}, 23:20:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'tests': ['damp', 'tps']}, 23:20:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['dromaeo_dom']}, 23:20:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:20:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'other-e10s': {'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['a11yr', 23:20:07 INFO - 'ts_paint', 23:20:07 INFO - 'tpaint', 23:20:07 INFO - 'sessionrestore', 23:20:07 INFO - 'sessionrestore_no_auto_restore', 23:20:07 INFO - 'tabpaint']}, 23:20:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['tsvgx', 23:20:07 INFO - 'tsvgr_opacity', 23:20:07 INFO - 'tart', 23:20:07 INFO - 'tscrollx', 23:20:07 INFO - 'cart']}, 23:20:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:20:07 INFO - 'tsvgr_opacity', 23:20:07 INFO - 'tart', 23:20:07 INFO - 'tscrollx', 23:20:07 INFO - 'cart']}, 23:20:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'talos_options': ['--disable-e10s'], 23:20:07 INFO - 'tests': ['tp5o']}, 23:20:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'tests': ['tp5o']}, 23:20:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'talos_options': ['--disable-e10s', 23:20:07 INFO - '--xperf_path', 23:20:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:07 INFO - 'tests': ['tp5n']}, 23:20:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:20:07 INFO - 'talos_options': ['--xperf_path', 23:20:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:20:07 INFO - 'tests': ['tp5n']}}, 23:20:07 INFO - 'talos.zip': {'path': '', 23:20:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:20:07 INFO - Running post-action listener: _resource_record_post_action 23:20:07 INFO - ##### 23:20:07 INFO - ##### Running create-virtualenv step. 23:20:07 INFO - ##### 23:20:07 INFO - Running pre-action listener: _resource_record_pre_action 23:20:07 INFO - Running main action method: create_virtualenv 23:20:07 INFO - Creating virtualenv /builds/slave/test/build/venv 23:20:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:20:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:20:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:20:08 INFO - Using real prefix '/tools/python27' 23:20:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:20:08 INFO - Installing distribute.............................................................................................................................................................................................done. 23:20:11 INFO - Installing pip.................done. 23:20:11 INFO - Return code: 0 23:20:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:11 INFO - 'HOME': '/Users/cltbld', 23:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:11 INFO - 'LOGNAME': 'cltbld', 23:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:11 INFO - 'MOZ_NO_REMOTE': '1', 23:20:11 INFO - 'NO_EM_RESTART': '1', 23:20:11 INFO - 'PAGER': '/bin/cat', 23:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:11 INFO - 'PWD': '/builds/slave/test', 23:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:11 INFO - 'SHELL': '/bin/bash', 23:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:11 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:11 INFO - 'USER': 'cltbld', 23:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:11 INFO - 'XPC_FLAGS': '0x0', 23:20:11 INFO - 'XPC_SERVICE_NAME': '0', 23:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:20:11 INFO - Cleaning up... 23:20:11 INFO - Return code: 0 23:20:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 23:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:11 INFO - 'HOME': '/Users/cltbld', 23:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:11 INFO - 'LOGNAME': 'cltbld', 23:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:11 INFO - 'MOZ_NO_REMOTE': '1', 23:20:11 INFO - 'NO_EM_RESTART': '1', 23:20:11 INFO - 'PAGER': '/bin/cat', 23:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:11 INFO - 'PWD': '/builds/slave/test', 23:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:11 INFO - 'SHELL': '/bin/bash', 23:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:11 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:11 INFO - 'USER': 'cltbld', 23:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:11 INFO - 'XPC_FLAGS': '0x0', 23:20:11 INFO - 'XPC_SERVICE_NAME': '0', 23:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:12 INFO - Downloading/unpacking psutil>=0.7.1 23:20: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 23:20: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 23:20: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 23:20: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 23:20: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 23:20: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 23:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:20:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:20:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:20:15 INFO - Installing collected packages: psutil 23:20:15 INFO - Running setup.py install for psutil 23:20:15 INFO - building 'psutil._psutil_osx' extension 23:20:15 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 23:20:16 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 23:20:16 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 23:20:16 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 23:20:16 INFO - building 'psutil._psutil_posix' extension 23:20:16 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 23:20:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:20:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:20:16 INFO - ^ 23:20:16 INFO - 1 warning generated. 23:20:16 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 23:20:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:20:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:20:16 INFO - Successfully installed psutil 23:20:16 INFO - Cleaning up... 23:20:16 INFO - Return code: 0 23:20:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:20:16 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')]} 23:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:16 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')]} 23:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:16 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:16 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 23:20:16 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 23:20:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:16 INFO - 'HOME': '/Users/cltbld', 23:20:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:16 INFO - 'LOGNAME': 'cltbld', 23:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:16 INFO - 'MOZ_NO_REMOTE': '1', 23:20:16 INFO - 'NO_EM_RESTART': '1', 23:20:16 INFO - 'PAGER': '/bin/cat', 23:20:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:16 INFO - 'PWD': '/builds/slave/test', 23:20:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:16 INFO - 'SHELL': '/bin/bash', 23:20:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:16 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:16 INFO - 'USER': 'cltbld', 23:20:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:16 INFO - 'XPC_FLAGS': '0x0', 23:20:16 INFO - 'XPC_SERVICE_NAME': '0', 23:20:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:20:19 INFO - Installing collected packages: mozsystemmonitor 23:20:19 INFO - Running setup.py install for mozsystemmonitor 23:20:19 INFO - Successfully installed mozsystemmonitor 23:20:19 INFO - Cleaning up... 23:20:19 INFO - Return code: 0 23:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:19 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:19 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 23:20:19 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 23:20:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:19 INFO - 'HOME': '/Users/cltbld', 23:20:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:19 INFO - 'LOGNAME': 'cltbld', 23:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:19 INFO - 'MOZ_NO_REMOTE': '1', 23:20:19 INFO - 'NO_EM_RESTART': '1', 23:20:19 INFO - 'PAGER': '/bin/cat', 23:20:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:19 INFO - 'PWD': '/builds/slave/test', 23:20:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:19 INFO - 'SHELL': '/bin/bash', 23:20:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:19 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:19 INFO - 'USER': 'cltbld', 23:20:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:19 INFO - 'XPC_FLAGS': '0x0', 23:20:19 INFO - 'XPC_SERVICE_NAME': '0', 23:20:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:20 INFO - Downloading/unpacking blobuploader==1.2.4 23:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:22 INFO - Downloading blobuploader-1.2.4.tar.gz 23:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:20:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:22 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 23:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:20:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:20:23 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 23:20:23 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 23:20:23 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 23:20:23 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 23:20:23 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 23:20:23 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 23:20:23 INFO - Downloading docopt-0.6.1.tar.gz 23:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:20:23 INFO - Installing collected packages: blobuploader, requests, docopt 23:20:23 INFO - Running setup.py install for blobuploader 23:20:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:20:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:20:24 INFO - Running setup.py install for requests 23:20:24 INFO - Running setup.py install for docopt 23:20:24 INFO - Successfully installed blobuploader requests docopt 23:20:24 INFO - Cleaning up... 23:20:24 INFO - Return code: 0 23:20:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:24 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:24 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 23:20:24 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 23:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:24 INFO - 'HOME': '/Users/cltbld', 23:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:24 INFO - 'LOGNAME': 'cltbld', 23:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:24 INFO - 'MOZ_NO_REMOTE': '1', 23:20:24 INFO - 'NO_EM_RESTART': '1', 23:20:24 INFO - 'PAGER': '/bin/cat', 23:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:24 INFO - 'PWD': '/builds/slave/test', 23:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:24 INFO - 'SHELL': '/bin/bash', 23:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:24 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:24 INFO - 'USER': 'cltbld', 23:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:24 INFO - 'XPC_FLAGS': '0x0', 23:20:24 INFO - 'XPC_SERVICE_NAME': '0', 23:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-EKid6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6x3voR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-VC4KbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-vxonz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-RFvwsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-8_VuYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-kwKBFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-tsb7Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-M5_Gy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xjZKOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-EdlXpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-N_h_A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-9JKAfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-wV6zF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-vyZC3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-4W6vvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-z0R867-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:20:26 INFO - Running setup.py install for manifestparser 23:20:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:20:26 INFO - Running setup.py install for mozcrash 23:20:27 INFO - Running setup.py install for mozdebug 23:20:27 INFO - Running setup.py install for mozdevice 23:20:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Running setup.py install for mozfile 23:20:27 INFO - Running setup.py install for mozhttpd 23:20:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Running setup.py install for mozinfo 23:20:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Running setup.py install for mozInstall 23:20:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:20:27 INFO - Running setup.py install for mozleak 23:20:28 INFO - Running setup.py install for mozlog 23:20:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Running setup.py install for moznetwork 23:20:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Running setup.py install for mozprocess 23:20:28 INFO - Running setup.py install for mozprofile 23:20:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Running setup.py install for mozrunner 23:20:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:20:28 INFO - Running setup.py install for mozscreenshot 23:20:29 INFO - Running setup.py install for moztest 23:20:29 INFO - Running setup.py install for mozversion 23:20:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:20:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:20:29 INFO - Cleaning up... 23:20:29 INFO - Return code: 0 23:20:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:29 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:29 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 23:20:29 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 23:20:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:29 INFO - 'HOME': '/Users/cltbld', 23:20:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:29 INFO - 'LOGNAME': 'cltbld', 23:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:29 INFO - 'MOZ_NO_REMOTE': '1', 23:20:29 INFO - 'NO_EM_RESTART': '1', 23:20:29 INFO - 'PAGER': '/bin/cat', 23:20:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:29 INFO - 'PWD': '/builds/slave/test', 23:20:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:29 INFO - 'SHELL': '/bin/bash', 23:20:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:29 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:29 INFO - 'USER': 'cltbld', 23:20:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:29 INFO - 'XPC_FLAGS': '0x0', 23:20:29 INFO - 'XPC_SERVICE_NAME': '0', 23:20:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:29 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-1unFkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:29 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)) 23:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:29 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-w0nr1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:29 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)) 23:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:29 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-JaOiX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:29 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)) 23:20:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:29 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-pBGPfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Nf3e9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-_G2LKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ptqj75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-btyxJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-QsMiIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FHftKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Oc612M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-zm3hHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:30 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)) 23:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:30 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-BkGTFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:31 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)) 23:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-pKFkZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:31 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)) 23:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-kumFJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:31 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)) 23:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-jw2c_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:31 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)) 23:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:31 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-UTf07F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:31 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)) 23:20:31 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)) 23:20:31 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)) 23:20:31 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)) 23:20:31 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)) 23:20:31 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)) 23:20:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:20:31 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 23:20:31 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 23:20:31 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 23:20:31 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 23:20:31 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 23:20:31 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 23:20:33 INFO - Downloading blessings-1.6.tar.gz 23:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:20:33 INFO - Installing collected packages: blessings 23:20:33 INFO - Running setup.py install for blessings 23:20:34 INFO - Successfully installed blessings 23:20:34 INFO - Cleaning up... 23:20:34 INFO - Return code: 0 23:20:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:34 INFO - Reading from file tmpfile_stdout 23:20:34 INFO - Current package versions: 23:20:34 INFO - blessings == 1.6 23:20:34 INFO - blobuploader == 1.2.4 23:20:34 INFO - docopt == 0.6.1 23:20:34 INFO - manifestparser == 1.1 23:20:34 INFO - mozInstall == 1.12 23:20:34 INFO - mozcrash == 0.17 23:20:34 INFO - mozdebug == 0.1 23:20:34 INFO - mozdevice == 0.48 23:20:34 INFO - mozfile == 1.2 23:20:34 INFO - mozhttpd == 0.7 23:20:34 INFO - mozinfo == 0.9 23:20:34 INFO - mozleak == 0.1 23:20:34 INFO - mozlog == 3.1 23:20:34 INFO - moznetwork == 0.27 23:20:34 INFO - mozprocess == 0.22 23:20:34 INFO - mozprofile == 0.28 23:20:34 INFO - mozrunner == 6.11 23:20:34 INFO - mozscreenshot == 0.1 23:20:34 INFO - mozsystemmonitor == 0.0 23:20:34 INFO - moztest == 0.7 23:20:34 INFO - mozversion == 1.4 23:20:34 INFO - psutil == 3.1.1 23:20:34 INFO - requests == 1.2.3 23:20:34 INFO - wsgiref == 0.1.2 23:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:34 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:34 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 23:20:34 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 23:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:34 INFO - 'HOME': '/Users/cltbld', 23:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:34 INFO - 'LOGNAME': 'cltbld', 23:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:34 INFO - 'MOZ_NO_REMOTE': '1', 23:20:34 INFO - 'NO_EM_RESTART': '1', 23:20:34 INFO - 'PAGER': '/bin/cat', 23:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:34 INFO - 'PWD': '/builds/slave/test', 23:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:34 INFO - 'SHELL': '/bin/bash', 23:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:34 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:34 INFO - 'USER': 'cltbld', 23:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:34 INFO - 'XPC_FLAGS': '0x0', 23:20:34 INFO - 'XPC_SERVICE_NAME': '0', 23:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 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)) 23:20:34 INFO - Cleaning up... 23:20:34 INFO - Return code: 0 23:20:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:34 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 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:34 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 23:20:34 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 23:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:34 INFO - 'HOME': '/Users/cltbld', 23:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:34 INFO - 'LOGNAME': 'cltbld', 23:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:34 INFO - 'MOZ_NO_REMOTE': '1', 23:20:34 INFO - 'NO_EM_RESTART': '1', 23:20:34 INFO - 'PAGER': '/bin/cat', 23:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:34 INFO - 'PWD': '/builds/slave/test', 23:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:34 INFO - 'SHELL': '/bin/bash', 23:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:34 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:34 INFO - 'USER': 'cltbld', 23:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:34 INFO - 'XPC_FLAGS': '0x0', 23:20:34 INFO - 'XPC_SERVICE_NAME': '0', 23:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:34 INFO - Downloading/unpacking jsonschema 23:20:34 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 23:20:34 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 23:20:34 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 23:20:34 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 23:20:34 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 23:20:34 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 23:20:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:20:37 INFO - Downloading/unpacking functools32 (from jsonschema) 23:20:37 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 23:20:37 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 23:20:37 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 23:20:37 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 23:20:37 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 23:20:37 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 23:20:37 INFO - Downloading functools32-3.2.3-2.tar.gz 23:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:20:37 INFO - warning: no files found matching '*.txt' 23:20:37 INFO - no previously-included directories found matching 'build' 23:20:37 INFO - no previously-included directories found matching 'dist' 23:20:37 INFO - no previously-included directories found matching '.git*' 23:20:37 INFO - Installing collected packages: jsonschema, functools32 23:20:37 INFO - Running setup.py install for functools32 23:20:38 INFO - warning: no files found matching '*.txt' 23:20:38 INFO - no previously-included directories found matching 'build' 23:20:38 INFO - no previously-included directories found matching 'dist' 23:20:38 INFO - no previously-included directories found matching '.git*' 23:20:38 INFO - Successfully installed jsonschema functools32 23:20:38 INFO - Cleaning up... 23:20:38 INFO - Return code: 0 23:20:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bead420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae2d63e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, '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.mhsXlbBGrR/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.9o4m28sDoI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 23:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:20:38 INFO - 'HOME': '/Users/cltbld', 23:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:20:38 INFO - 'LOGNAME': 'cltbld', 23:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:38 INFO - 'MOZ_NO_REMOTE': '1', 23:20:38 INFO - 'NO_EM_RESTART': '1', 23:20:38 INFO - 'PAGER': '/bin/cat', 23:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:38 INFO - 'PWD': '/builds/slave/test', 23:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:20:38 INFO - 'SHELL': '/bin/bash', 23:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:20:38 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:20:38 INFO - 'USER': 'cltbld', 23:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:38 INFO - 'XPC_FLAGS': '0x0', 23:20:38 INFO - 'XPC_SERVICE_NAME': '0', 23:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:38 INFO - Downloading/unpacking flake8 23:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:20:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:20:40 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 23:20:40 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 23:20:40 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 23:20:40 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 23:20:40 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 23:20:40 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 23:20:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:20:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 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 23:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:20:42 INFO - no previously-included directories found matching 'docs/_build' 23:20:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:20:42 INFO - Running setup.py install for pep8 23:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:20:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:20:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:20:42 INFO - no previously-included directories found matching 'docs/_build' 23:20:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:20:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:20:42 INFO - Cleaning up... 23:20:42 INFO - Return code: 0 23:20:42 INFO - Running post-action listener: _resource_record_post_action 23:20:42 INFO - Running post-action listener: _start_resource_monitoring 23:20:42 INFO - Starting resource monitoring. 23:20:42 INFO - ##### 23:20:42 INFO - ##### Running install step. 23:20:42 INFO - ##### 23:20:42 INFO - Running pre-action listener: _resource_record_pre_action 23:20:42 INFO - Running main action method: install 23:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:42 INFO - Reading from file tmpfile_stdout 23:20:42 INFO - Detecting whether we're running mozinstall >=1.0... 23:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:20:42 INFO - Reading from file tmpfile_stdout 23:20:42 INFO - Output received: 23:20:42 INFO - Usage: mozinstall [options] installer 23:20:42 INFO - Options: 23:20:42 INFO - -h, --help show this help message and exit 23:20:42 INFO - -d DEST, --destination=DEST 23:20:42 INFO - Directory to install application into. [default: 23:20:42 INFO - "/builds/slave/test"] 23:20:42 INFO - --app=APP Application being installed. [default: firefox] 23:20:42 INFO - mkdir: /builds/slave/test/build/application 23:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:21:15 INFO - Reading from file tmpfile_stdout 23:21:15 INFO - Output received: 23:21:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:21:15 INFO - Running post-action listener: _resource_record_post_action 23:21:15 INFO - ##### 23:21:15 INFO - ##### Running run-tests step. 23:21:15 INFO - ##### 23:21:15 INFO - Running pre-action listener: _resource_record_pre_action 23:21:15 INFO - Running main action method: run_tests 23:21:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:21:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:21:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:21:15 INFO - 2016-04-23 23:21:15.878 screenresolution[1646:9297] starting screenresolution argv=screenresolution get 23:21:15 INFO - 2016-04-23 23:21:15.881 screenresolution[1646:9297] Display 0: 1600x1200x32@60 23:21:15 INFO - 2016-04-23 23:21:15.887 screenresolution[1647:9299] starting screenresolution argv=screenresolution list 23:21:15 INFO - Available Modes on Display 0 23:21:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:21:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:21:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:21:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:21:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:21:16 INFO - Intel Iris: 23:21:16 INFO - Chipset Model: Intel Iris 23:21:16 INFO - Type: GPU 23:21:16 INFO - Bus: Built-In 23:21:16 INFO - VRAM (Dynamic, Max): 1536 MB 23:21:16 INFO - Vendor: Intel (0x8086) 23:21:16 INFO - Device ID: 0x0a2e 23:21:16 INFO - Revision ID: 0x0009 23:21:16 INFO - Displays: 23:21:16 INFO - Display: 23:21:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:21:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:21:16 INFO - Display Serial Number: 1600x1200 60 23:21:16 INFO - Main Display: Yes 23:21:16 INFO - Mirror: Off 23:21:16 INFO - Online: Yes 23:21:16 INFO - Rotation: Supported 23:21:16 INFO - Return code: 0 23:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:21:16 INFO - Python 2.7.3 23:21:16 INFO - Return code: 0 23:21:16 INFO - grabbing minidump binary from tooltool 23:21:16 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')]} 23:21:16 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 0x10bd3ce00>, '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 0x10bb65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd37b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:21:16 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 23:21:16 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 23:21:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:21:16 INFO - Return code: 0 23:21:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:21:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:21:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:21:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:21:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:21:17 INFO - Return code: 0 23:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 23:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 23:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mhsXlbBGrR/Render', 23:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:21:17 INFO - 'HOME': '/Users/cltbld', 23:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:21:17 INFO - 'LOGNAME': 'cltbld', 23:21:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:21:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:17 INFO - 'MOZ_NO_REMOTE': '1', 23:21:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:21:17 INFO - 'NO_EM_RESTART': '1', 23:21:17 INFO - 'PAGER': '/bin/cat', 23:21:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:17 INFO - 'PWD': '/builds/slave/test', 23:21:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:21:17 INFO - 'SHELL': '/bin/bash', 23:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9o4m28sDoI/Listeners', 23:21:17 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 23:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:21:17 INFO - 'USER': 'cltbld', 23:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:17 INFO - 'XPC_FLAGS': '0x0', 23:21:17 INFO - 'XPC_SERVICE_NAME': '0', 23:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:21:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 23:21:17 INFO - mozversion application_buildid: 20160423222844 23:21:17 INFO - mozversion application_changeset: f47b31f50a9a82984640ff6e17a86239808c8e15 23:21:17 INFO - mozversion application_display_name: Nightly 23:21:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:21:17 INFO - mozversion application_name: Firefox 23:21:17 INFO - mozversion application_remotingname: firefox 23:21:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:21:17 INFO - mozversion application_vendor: Mozilla 23:21:17 INFO - mozversion application_version: 48.0a1 23:21:17 INFO - mozversion platform_buildid: 20160423222844 23:21:17 INFO - mozversion platform_changeset: f47b31f50a9a82984640ff6e17a86239808c8e15 23:21:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:21:17 INFO - mozversion platform_version: 48.0a1 23:21:17 INFO - using testdate: 1461478877 23:21:17 INFO - actual date: 1461478877 23:21:17 INFO - starting webserver on 'localhost:49271' 23:21:17 INFO - SUITE-START | Running 2 tests 23:21:17 INFO - TEST-START | dromaeo_css 23:21:17 INFO - operating with platform_type : mac_ 23:21:17 INFO - Initialising browser for dromaeo_css test... 23:21:17 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp4Pz9ja/profile http://localhost:49271/getInfo.html) 23:21:19 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 23:21:19 INFO - PROCESS | 1665 | colorDepth:24 23:21:19 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 23:21:19 INFO - PROCESS | 1665 | __metrics 23:21:19 INFO - PROCESS | 1665 | 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" 23:21:19 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:21:20 INFO - TEST-INFO | 1665: exit 0 23:21:20 INFO - Browser initialized. 23:21:20 INFO - Running cycle 1/1 for dromaeo_css test... 23:21:20 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp4Pz9ja/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:21:32 INFO - PROCESS | 1668 | RSS: Main: 239259648 23:21:32 INFO - PROCESS | 1668 | 23:22:24 INFO - PROCESS | 1668 | 1461478944050 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] 23:24:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 23:24:35 INFO - PROCESS | 1668 | RSS: Main: 371212288 23:24:35 INFO - PROCESS | 1668 | 23:27:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 23:27:39 INFO - PROCESS | 1668 | RSS: Main: 383492096 23:27:39 INFO - PROCESS | 1668 | 23:30:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 23:30:42 INFO - PROCESS | 1668 | RSS: Main: 376348672 23:30:42 INFO - PROCESS | 1668 | 23:33:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 23:33:45 INFO - PROCESS | 1668 | RSS: Main: 372908032 23:33:45 INFO - PROCESS | 1668 | 23:36:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 23:36:49 INFO - PROCESS | 1668 | RSS: Main: 335306752 23:36:49 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 23:39:52 INFO - PROCESS | 1668 | RSS: Main: 412151808 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | __start_tp_report 23:39:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 23:39:52 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 23:39:52 INFO - PROCESS | 1668 | |i|pagename|runs| 23:39:52 INFO - PROCESS | 1668 | |0;dojo.html;3211.4379983502886;3436.31273745251;3468.79187248765;3470.791752494849;3511.192425742079;5589.7205139742955;5659.886802263953;5665.745041473133;5666.235058267138;5703.74333155008;5634.3520495143075;5693.373728889829;5694.629849059808;5697.373288938214;5699.002674531951;5152.948470515303;5192.169252919533;5213.113770658997;5222.451642577532;5287.894242115155;5283.63014588977;5283.63014588979;5283.841484755444;5285.524302812746;5287.576993840503;5183.818566350178;5233.110371236899;5238.7642556084875;5247.186686063647;5310.123829568117;5134.9986752583445;5175.197844334134;5175.585953123741;5180.559652429548;5220.451852555465;5112.590992720573;5125.1287281162295;5131.717755523445;5150.665206761549;5191.636585439021;4619.653525985531;5520.309961254843;5523.7790488380415;5562.471565201299;5581.6371935824045;6191.628502289832;6240.4071613196675;6240.469560087398;6245.125682404467;6254.0931564923285;6093.68985668079;6138.51101655979;6214.316425193225;6216.098665693495;6246.219222597176;5742.942570574324;5783.392743761929;5790.507806836424;5797.768089276466;5823.330317013513;6241.812745617548;6245.28179259391;6250.749970001149;6255.624662520263;6259.311475737665;5999.040153575407;6063.696305294383;6122.877542449215;6164.291106522717;6183.598066125687;6199.535034872312;6206.72069756862;6225.750969961151;6251.281102673251;6262.46769024638;6181.320054793969;6216.875662486816;6222.471089957405;6235.875282494416;6268.341824108494;6098.462484929982;6187.381261873867;6191.907121393183;6204.658743769046;6236.532260080512;4907.70553766768;4908.828191013369;4943.703377797344;4950.3069570260195;4986.825461108844;4400.69195156336;4422.75674837887;4424.911501769947;4429.136318417942;4468.843590474317;5679.829605111853;5682.374938756733;5694.145878118233;5715.113722668542;5770.24986751728;6070.514358851281;6127.448529632355;6181;6191.659458729723;6194.194754681863;5652.463016013472;5664.830055098354;5683.147527870852;5696.430356964271;5715.8856822864145;5368.32895888014;5382.165764306539;5389.568834493231;5390.326209223847;5395.163749618815;5377.516023557899;6153.784617538454;6303.747850086037;6324.30432652417;6339.366063393623;4725.40932383452;6151.507879369729;6194.938050619617;6234.501239900887;6243.406876346739;6226.439620434183;6289.779857705142;6298.779542716166;6303.9684801575695;6315.778947736807;6139;6183.288921773874;6191.752329906753;6196.81409557714;6221.253449586078;5430.972845135749;6205.720742566505;6208.379162083756;6226.283977342664;6239.937600623935;5937.643741375531;6048.697565121638;6120;6138.785142519991;6139.4781443577795;4964.851054468371;6084.056971169476;6095.529019716752;6105.84735381619;6144.631322120687;5900.291964964232;5934.584579079596;5963.7912673056235;5965.731542080704;5985.730642121202;5884.47039766423;6026.246719160105;6118.449339559461;6119.3268740437625;6121.693915304306;5767.509761670305;5831.912521312269;5842.152887831326;5885.08781138907;5961.642301461753 23:39:52 INFO - PROCESS | 1668 | |1;ext.html;505.3026822984281;526.7576914619275;537.0279793573629;541.9756110975005;573.1345668041258;30229.546556801666;30976.845115774446;30986.845065774694;30987.535186972185;31017.844910775442;31309;31780.68219317806;39314.60685393145;40728.185436291256;40807.59192408075;9406.811863762738;9627.566759495805;9640.951795241013;9647.614095436174;9666.565004574775;8294.087650358486;8544.18830211129;9440.103190196955;9647.131758141766;9662.710118696416;8698.826023479527;9256.72229833106;9341.53292335384;11341.829872551918;11726.882731172707;11341.603043893425;11464.885351146508;11465.942670286679;11466.942665286704;11474.368909710047;8448.23965843071;9337.953310233406;11335.773284534345;11478.426078696031;11604.883951160466;38391.61608383936;38905.80547097247;38933.805330973446;38973.02567435808;38984.41523377151;3283.1956170738085;3293.5718356613725;3343;3484.8083355415442;3640.0535860676414;27437.58843617347;28008.299792505146;28098.578521322197;28296.292592685142;28344.433111337865;2719.1978366381963;2748.1618106477517;2803.4533266013136;2810.3676672748675;2864.5273529867545;495908;502488;504461;506265.46867265797;507780;61413.38586614166;62402.37597624057;62426.37573624206;62490.375096249365;62513;65653.67173164104;65886.0117098244;65970.67014664992;65996.68006639936;66066.0090098649;16114.75827862583;16726.330946762235;16729.079900605582;16730;16754.581135471468;12288.815667764991;12290.139690221777;12311.322877241837;12317.199382040139;12327.321997290055;14777.335019924129;15281.38874445032;16449.506514804576;16641.750373744162;17033.48899533016;5982.611130276605;6180.907286390708;6197.566170368121;6229.345918678564;6232.8130156095385;975.6146322202832;980.2011360740973;992.0525897767615;1010.939343639384;1027.5889644142253;27008;28497.71502284992;28926.276843079093;29418.558721619193;29676.258093547403;1115.9609413670646;1165.3532289579196;1179.2511755035443;1192.701824543864;1232.4761976160096;15125.319360628799;15217.543473695807;15331.310091045707;15349.783567054388;15411.537653870178;616167;621168.8941555263;624632;625058;626011.8699406474;58536.707316463995;60514.69742651346;60592;60723.69638151869;60817;1465.465105236581;1475.6974820162056;1486.851314868526;1489.8063251777417;1493.5967288831955;23949.657046077045;28782.712172878004;29188;29706;29720.702792972657;51761;52019;52412.73793631008;52417;52530.73734631302;547128;548010;550602;551114;552775;26298.21105366842;26739.86630066837;27147.86426067857;27191.59212611852;36218.09454763652;36380;37944.620553794106;40168.59831401648;47290.344837930505;47968.760156198994;28194.718052819208;35743.46384804282;36525.0494445843;36940;37117.81441092777;35890.32486545069;35957.741479048105;36595.90212293636;36759;37046;36270.09324766902;36346.63653363432;36528.45207321946;36734.081647959014;37034;31561.526577100904;32021.8775575383;32280.192995175308;32360.676393235768;32416;23902.88048559746;24102.39744006414;24195.395115122265;24472.265832025067;24527.632085518373 23:39:52 INFO - PROCESS | 1668 | |2;jquery.html;336.50701721977305;398.9401589761537;400.7745088097963;404.65604236399054;411.5760766410596;14942.551723448314;17024.574385640364;17255.91372043141;20247.493812654673;20278.49303767405;16018.19909004551;16644.750328745078;19865.404037878852;20560.897195514;20796.792032079673;5895.941040589592;6061.818145455643;6112.144299798032;6117.44942955134;6133.2946711128125;5872.236609240793;5979.342272350038;5980.970095149518;6090.878182436349;6108.175396321484;6041.577089603729;6062.03007518797;6066.241719785027;6072.05883088122;6090.0816242883575;5810.360860305363;6088.299845517778;6099.420555047263;6102.237220347457;6111.388861113897;5298.390685071227;5305.495977882095;5322.441143679896;5331;5335.33308336458;18135.546611334692;25173.748262517507;26380.60429093565;26559.60160597573;26583.73416265832;2278.236790675126;2435.866027368494;2567.281161274846;2588.171785028773;2744.8353098813936;14793.630159246104;14802.925985370004;15037.323320450607;15052.623684407868;15058.247087645683;1688.814230434651;1704.6846333428355;1743.3985275080076;1758.8944663320115;1807;100257.49871250597;101984.49007754914;103953.96046039595;106076;108215.45892270567;11273.267237629529;11352.943235283936;11368.602098926498;11419.143564232716;11551.884481155248;14648.414063437556;14733.92633036828;14767.778483322758;14782.334794934253;14800.703985920221;7005.299470052954;7373.963130184315;8570.571471426403;8693.000304964884;8749.650013999497;6944.51388402807;8547.40168188221;8578.313734901192;8660.653573857102;8682.86975695365;4511.1654343946475;4566.1552612766745;4568.33759104928;4627.120847039119;4672.322513235562;1879.4494542002628;1900.8669393142347;1943.3004118517322;1956.6575849226613;1998.490384951828;771.248033167657;775.3525805952094;797.8204903896693;915.0894859614726;962.5379817687549;19631.509212269808;20448.38654840357;20501.58996820085;20573;20945.89527052355;874.8932600260675;958.990410095904;977.0913050862766;1042.551702767802;1063.2079101069598;8261.958690206631;10472.842907356397;10566.049055585034;10620.840687389695;10643.84034239487;581685;584007;591270;607372;612619;124876.1268580972;133605;134505;136390.31804840913;143730;883.2580632268925;1009.4404145595073;1086.2721976275757;1086.7337502311825;1099.142668718401;17713.822861771216;18646.44060678182;18665.88004719721;18837.529061773566;18845.057747112314;39422.21155576815;40750;52400.68998274921;52445.47554524406;53068;65145.67427162834;65694.67152664207;65718;66671.66664166842;68449.65775171093;6762.222344430454;7866.803329916798;8027.478213916077;8041.959790201012;8488.660453581788;9296.256299495888;12052;12247.877521224673;12567.434465448894;12699.603043665375;10687.358758474516;10884.129269658566;10958.397288149228;11041.503132359223;11044.392558409365;10621.468926553487;10833;10835.133189344991;10835.404052776857;11329.71675708114;10825.809160992441;11238.381888996184;11317.377544234816;11348.829767553329;11415.714607134556;7772.378209743094;8003.19968003195;8170.877436838571;8346.958265208636;8419.579021049045;8964.238039766693;10128.240381971234;10314.27800053989;10538.051575358255;11026.503807328529 23:39:52 INFO - PROCESS | 1668 | |3;mootools.html;1421.8791402730767;1567.686462707458;1670.4320531019453;1742.668892910347;2038.867473614215;6732.73069077237;8207.425480216387;8209.302209312209;8222.753317400488;8606.827863442742;8556.74329770108;8624.69813556524;8694.695685651004;8704.303655707545;8710.128987101287;2416.3596646888545;2448.9510209795794;2450.0567281596536;2450.901963921441;2454;1888.7827899791494;2189.1462329691435;2258.977410225893;2259.9943025353723;2425.9393515162087;2228.843980921336;2392.437777122375;2482.9199298305207;2483.0688491815567;2488.4276616378243;2423.212455951805;2448.5470188015183;2464.322311364389;2465.3343597228827;2465.395977985387;2136.9786302136936;2423.09134074722;2461.3477428481465;2461.8276720629565;2464.408541949937;8506.064332923374;8822.558872056436;8828.07305232954;8828.779280517974;8840.292776577922;5203.869903252411;5397.919031214535;5403.621746477709;5404.000259951921;5408.702521361323;3512.051746028558;3536.469529570585;3626.165981824195;3636.127329440915;3639.854405823764;1011.4841430870309;1027.3733022856127;1031.2214278219897;1041.5989843910074;1043.2697112021615;11541.884581154165;11681.707957301136;11692.88307116935;11702.941485292604;11758.58844940423;4663.790129444184;4781.7740166117865;4814.8796280093275;4907.975460122748;4949.975250123798;10043.246756493292;10057.497125143713;10067.194624430029;10084.142847858015;10097.495125243708;5391.81128660495;5410.567154627621;5417.59368047398;5423.403425623178;5439.4288599696465;4860.878478038077;4931.827386041471;4946.678465899705;4960.603151747851;4965.131102057126;3098.4267910436192;3788.981055094762;3805.1438426354403;3820.67524260441;3959.7228194026716;1316.5984374765787;1368.548379034916;1369.1990185741454;1381.405995421978;1383.2392184298596;871.6469829718848;884.8893888263967;895.7984453497911;961.9470929098827;980.426070240814;4731.976340118346;5136.666116702402;5961.986462301419;5997.880042399128;6093.756249750049;948.3361646847235;986.3539381704994;990.1682586627268;1000.8198524265703;1021.9386836789816;3960.2277555876326;3965.266425711195;3996;4084.326086195744;4103.4460347853255;10501.684949451528;10912.672619821418;10936.617218397318;10977;11072.944635276934;10891.891081089088;11003.834942475869;11007.889921100686;11036.448177591248;11043.503042363112;7785.883211751715;8152.673893044212;8304.335653147855;8389.203025712548;8437.240648341678;5965.194698715618;6059.7612338574745;6066.817995460143;6135.355787642234;6138.877222455615;9983.301168918106;9986.500674966368;10003.94958529373;10027.348222365523;10049.598016079568;8313.792155196168;9806.313558050868;9921.107100361001;10229.130523905551;10276.332038417479;7522.097348318018;7592.278733520307;7660.578668173304;7666.731664391719;7672.271134242238;7929.770885512755;8189.262966333059;8225.642768943297;8313.750587482386;8331.95834020826;7347.338739513256;7425.997490338735;7452.441066920112;7535.13345965221;7609.162992070757;7118.5017048806085;7148.070750802362;7336.193018768038;7351.448641351813;7371.262873712586;6893.138357705287;6898.8620227596175;6981.895271570829;6986.580805151707;6987.301269873175;4921.876953076202;4941.061198372297;5022.874428139326;5060.240963855451;5061.797528098835;4215.156968606352;4968.925466117938;4982.252662100714;5073.289739436408;5159.071367153798 23:39:52 INFO - PROCESS | 1668 | |4;prototype.html;311.48604802076557;322.36976710530917;331.8390580568425;333.2568372529261;333.8380885270643;5781.277340332458;5976.910346344803;5989.98170311047;6040.516758659308;6066.636001839893;5695.572832037593;5894.999999999989;5960.642361458305;5974.761009559613;5996.52027837773;4518.909621807562;4551.542167229692;4557.701055199269;4569.885752856188;4576.153411618861;4300.419443375151;4347.673924455663;4473.418455600768;4528;4585.564371384713;3817.618238176188;4061.294256412299;4490;4494.1910456117885;4504.234280172363;3657.359962006665;3743.47591337213;4492.236319825637;4492.326151077348;4543.295789152687;3779.7543159694533;3910.4720862683457;3932.8791294480934;3933.940990885139;3936.881893543198;4629.8148074077;4747.83677998889;5703.3441154267375;5730.484256416901;5741.827745167651;5200.037992971313;5246.816361427332;5247.685138891678;5255.290535777659;5267.525922666979;5896.587238893279;6312.621242725451;6332.715027823759;6355.745770169187;6370.267419246799;3501.929961400783;3822.9869084692577;3969.2260009298197;4085.0400155963325;4242.5121111072;6712.362325579111;6798.184217893835;6801.5238933274195;6808.5914845109455;6812.6934287957165;3433.9656603433646;3588.2861238618425;4268.189044081614;4310.267254566731;4316.827326906889;4363.934540981888;4378.2119218540965;4381.7370957742;4385.364122202327;4393.154874952527;5106.514881086365;5116.158183054097;5127.410502744086;5133.024725302255;5155.716435596003;4710.764461776897;5526.696031718294;5863.736131874076;6335.493160547145;6589.538732288694;1474.1523623916291;1488.1740633948045;1491.940322387114;1493.3951749541236;1500.2798656644873;909.4361495872602;954.4604172467274;967.0184762466102;978.9070038346346;987.6345752071636;5850.8537286567325;5865.677387743715;5936.5547583931375;5942.376050514634;5983.61106528083;5500.614956952975;6076.900780601924;6489.67551622417;6500.609963402211;6504.869902601921;4494.955050449519;5829.863176680591;5865.325487568899;5925.48167029011;5963.701814909324;3458.515807786912;3466.7399945004227;3494.965050349515;3508.5088087667746;3514.2444374459615;6287.9056814147825;6660.8667826643195;6877;6905.654717264117;6911.239763626098;6750.966245168743;6771.492138089663;6781.355771201728;6787.864242715118;6844.452443804484;6019.217501724747;6103.579498156726;6563.785699645486;6828.180618325832;6867.175938887365;6588.736450541925;6610.867782644416;6621.867562648624;6631.574211544541;6635.303293154149;5166.509181627739;6488.631649448012;6529.204468770936;6547.738090476328;6565.507586931095;6847.726090956506;6891.138607674041;6895.275996020346;6905.721112033118;6936.237013928363;4263.786810659517;4266.87199384019;4274.487061552633;4280.764557949343;4283.593058659422;6151.630902145886;6291.276503202191;6607.768728094494;6611.900821487778;6617.305182955913;5304.098303288527;5404.756785944721;5788.739506722123;6314.431701146918;6412.2625898022325;6059.909101363572;6388.712507937061;6398.648074355955;6399.360063993563;6405.135306733718;5153.845384638467;5365.302510673588;5848.4151584841175;6170.629762214281;6277.780277690259;5243.606729495227;5279.313689220377;6147.354527774698;6235.314115447388;6410.61536307823;5445.945540544544;6262.09199666055;6273.96863015682;6280.497560195082;6282.811515654537 23:39:52 INFO - PROCESS | 1668 | |5;yui.html;631.9210098737658;662.2946561911565;747.9027726395568;748.0761259844091;792.6591565626778;15024.924875375622;15030.77453838192;15275.541733747978;15281.00673456226;15289.311980960856;13949.58151255464;14031.5088971886;14051.578452646438;14051.859481405183;14064.507742228998;899.2985471332371;937.7374335186158;940.8447606144978;941.8398872191743;942.0344147249056;726.9091363579553;921.262989608314;931.2922179143832;936.5551363102539;938.7653086728318;781.0510230070463;952.1906379577339;985.9901400986006;986.3933680786337;988.6342053440237;972.8978457261992;973.9724590556959;975.2441857560376;975.9072888075622;976.0288512929645;566.3119310038282;713.1442269276888;723.7358364197083;727.1928159742681;740.4779630360637;11507.136964727679;13851.930740346335;13889;13904.721905561933;13923.930380348134;12548.74902501954;12688.365581720876;12698.42857071434;12781;13163.802542961768;9791.951040244825;9888.505574721306;9937.304388692723;10189.082982531534;10365.689029329056;3050.923726906823;3442.087846720621;3478.4086705260165;3488.8778892738887;3749.4000959846567;80878;81516.59241703754;81816;81864;83015.5849220756;9452.64504484846;9751.951240243754;9856.457894815854;9875.851862222073;10045.748856278506;22382.32853014412;22485.100595976306;22485.775142248367;22489.88755056247;22500.32499025032;7211.603361815046;7257.237990011078;7348.816279592946;7418.369438597671;7437.776866694008;4002.1649428226615;4102.712810103324;4105.904288377875;4108.219438306772;4219.198352313112;3618.1135621772833;3685.207680348738;3685.207680348738;3690;3690.3541880170865;623.9844003899939;634.7556190866458;638.6455517188006;649.2695717318018;655.7737031750656;521.9269302297681;571.928508936383;584.9824505264849;593.4925638579039;612.2713970375239;7637.732679356196;7775.844483110306;7870.606469676493;7898.407619428566;8149.877751833727;546.7348336057009;564.5032371513042;571.1889117453227;587.4301927130676;595.3094410483818;3375.561177046968;3451.620321764604;3526.682598566141;3760.8683696070507;3866.439366291872;54781.63045923884;74169;93447.06552934383;94601.05398945922;94814;55330.786768529615;57405.42594574084;64417;67254.32745672579;68201;46654.766726166155;46714.06571868544;47748;49450.25824612706;58321.12518312228;7923;8116.75649730509;8219.219174178443;8272.545010024507;8395.790105247417;41120;41133;41234.38148427716;41439.54961576451;42399.788001059795;56414;56957;57088.42911570997;58033.4196658028;58036.129458059004;10590.205734569783;10872.184586156229;11113.444327783416;11129.054030407506;11370.772584548427;11737.823932640846;11972.880271197177;11975.461104250504;12171.878281217074;12235.632931012084;11266.098712103176;11374.94312528432;11464.082873370277;11640.476178571815;11736.471858766547;9516.33385662997;9592.280578956466;10826.242163048511;11206.38364889939;11681.240719353214;11211.215214934877;11290.096792256763;11360.772784544097;11572.826407603725;11576.24754390962;9234.307426942873;9393.701803312888;9471.621135154517;9775;10037.996200380196;8898.288136948899;9121.589528471368;9379.343445958717;9659.034096590285;9718.70843874685 23:39:52 INFO - PROCESS | 1668 | __end_tp_report 23:39:52 INFO - PROCESS | 1668 | __start_cc_report 23:39:52 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1284 23:39:52 INFO - PROCESS | 1668 | __end_cc_report 23:39:52 INFO - PROCESS | 1668 | __startTimestamp1461479992530__endTimestamp 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | ------- Summary: start ------- 23:39:52 INFO - PROCESS | 1668 | Number of tests: 6 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5698.26 Median:5884.47 stddev:631.83 (10.7%) stddev-sans-first:602.90 23:39:52 INFO - PROCESS | 1668 | Values: 3211.4 3436.3 3468.8 3470.8 3511.2 5589.7 5659.9 5665.7 5666.2 5703.7 5634.4 5693.4 5694.6 5697.4 5699.0 5152.9 5192.2 5213.1 5222.5 5287.9 5283.6 5283.6 5283.8 5285.5 5287.6 5183.8 5233.1 5238.8 5247.2 5310.1 5135.0 5175.2 5175.6 5180.6 5220.5 5112.6 5125.1 5131.7 5150.7 5191.6 4619.7 5520.3 5523.8 5562.5 5581.6 6191.6 6240.4 6240.5 6245.1 6254.1 6093.7 6138.5 6214.3 6216.1 6246.2 5742.9 5783.4 5790.5 5797.8 5823.3 6241.8 6245.3 6250.7 6255.6 6259.3 5999.0 6063.7 6122.9 6164.3 6183.6 6199.5 6206.7 6225.8 6251.3 6262.5 6181.3 6216.9 6222.5 6235.9 6268.3 6098.5 6187.4 6191.9 6204.7 6236.5 4907.7 4908.8 4943.7 4950.3 4986.8 4400.7 4422.8 4424.9 4429.1 4468.8 5679.8 5682.4 5694.1 5715.1 5770.2 6070.5 6127.4 6181.0 6191.7 6194.2 5652.5 5664.8 5683.1 5696.4 5715.9 5368.3 5382.2 5389.6 5390.3 5395.2 5377.5 6153.8 6303.7 6324.3 6339.4 4725.4 6151.5 6194.9 6234.5 6243.4 6226.4 6289.8 6298.8 6304.0 6315.8 6139.0 6183.3 6191.8 6196.8 6221.3 5431.0 6205.7 6208.4 6226.3 6239.9 5937.6 6048.7 6120.0 6138.8 6139.5 4964.9 6084.1 6095.5 6105.8 6144.6 5900.3 5934.6 5963.8 5965.7 5985.7 5884.5 6026.2 6118.4 6119.3 6121.7 5767.5 5831.9 5842.2 5885.1 5961.6 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:68624.02 Median:36087.92 stddev:149898.99 (415.4%) stddev-sans-first:150232.24 23:39:52 INFO - PROCESS | 1668 | Values: 505.3 526.8 537.0 542.0 573.1 30229.5 30976.8 30986.8 30987.5 31017.8 31309.0 31780.7 39314.6 40728.2 40807.6 9406.8 9627.6 9641.0 9647.6 9666.6 8294.1 8544.2 9440.1 9647.1 9662.7 8698.8 9256.7 9341.5 11341.8 11726.9 11341.6 11464.9 11465.9 11466.9 11474.4 8448.2 9338.0 11335.8 11478.4 11604.9 38391.6 38905.8 38933.8 38973.0 38984.4 3283.2 3293.6 3343.0 3484.8 3640.1 27437.6 28008.3 28098.6 28296.3 28344.4 2719.2 2748.2 2803.5 2810.4 2864.5 495908.0 502488.0 504461.0 506265.5 507780.0 61413.4 62402.4 62426.4 62490.4 62513.0 65653.7 65886.0 65970.7 65996.7 66066.0 16114.8 16726.3 16729.1 16730.0 16754.6 12288.8 12290.1 12311.3 12317.2 12327.3 14777.3 15281.4 16449.5 16641.8 17033.5 5982.6 6180.9 6197.6 6229.3 6232.8 975.6 980.2 992.1 1010.9 1027.6 27008.0 28497.7 28926.3 29418.6 29676.3 1116.0 1165.4 1179.3 1192.7 1232.5 15125.3 15217.5 15331.3 15349.8 15411.5 616167.0 621168.9 624632.0 625058.0 626011.9 58536.7 60514.7 60592.0 60723.7 60817.0 1465.5 1475.7 1486.9 1489.8 1493.6 23949.7 28782.7 29188.0 29706.0 29720.7 51761.0 52019.0 52412.7 52417.0 52530.7 547128.0 548010.0 550602.0 551114.0 552775.0 26298.2 26739.9 27147.9 27191.6 36218.1 36380.0 37944.6 40168.6 47290.3 47968.8 28194.7 35743.5 36525.0 36940.0 37117.8 35890.3 35957.7 36595.9 36759.0 37046.0 36270.1 36346.6 36528.5 36734.1 37034.0 31561.5 32021.9 32280.2 32360.7 32416.0 23902.9 24102.4 24195.4 24472.3 24527.6 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34178.02 Median:13804.81 stddev:99175.16 (718.4%) stddev-sans-first:99420.82 23:39:52 INFO - PROCESS | 1668 | Values: 336.5 398.9 400.8 404.7 411.6 14942.6 17024.6 17255.9 20247.5 20278.5 16018.2 16644.8 19865.4 20560.9 20796.8 5895.9 6061.8 6112.1 6117.4 6133.3 5872.2 5979.3 5981.0 6090.9 6108.2 6041.6 6062.0 6066.2 6072.1 6090.1 5810.4 6088.3 6099.4 6102.2 6111.4 5298.4 5305.5 5322.4 5331.0 5335.3 18135.5 25173.7 26380.6 26559.6 26583.7 2278.2 2435.9 2567.3 2588.2 2744.8 14793.6 14802.9 15037.3 15052.6 15058.2 1688.8 1704.7 1743.4 1758.9 1807.0 100257.5 101984.5 103954.0 106076.0 108215.5 11273.3 11352.9 11368.6 11419.1 11551.9 14648.4 14733.9 14767.8 14782.3 14800.7 7005.3 7374.0 8570.6 8693.0 8749.7 6944.5 8547.4 8578.3 8660.7 8682.9 4511.2 4566.2 4568.3 4627.1 4672.3 1879.4 1900.9 1943.3 1956.7 1998.5 771.2 775.4 797.8 915.1 962.5 19631.5 20448.4 20501.6 20573.0 20945.9 874.9 959.0 977.1 1042.6 1063.2 8262.0 10472.8 10566.0 10620.8 10643.8 581685.0 584007.0 591270.0 607372.0 612619.0 124876.1 133605.0 134505.0 136390.3 143730.0 883.3 1009.4 1086.3 1086.7 1099.1 17713.8 18646.4 18665.9 18837.5 18845.1 39422.2 40750.0 52400.7 52445.5 53068.0 65145.7 65694.7 65718.0 66671.7 68449.7 6762.2 7866.8 8027.5 8042.0 8488.7 9296.3 12052.0 12247.9 12567.4 12699.6 10687.4 10884.1 10958.4 11041.5 11044.4 10621.5 10833.0 10835.1 10835.4 11329.7 10825.8 11238.4 11317.4 11348.8 11415.7 7772.4 8003.2 8170.9 8347.0 8419.6 8964.2 10128.2 10314.3 10538.1 11026.5 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5715.69 Median:4936.44 stddev:3188.34 (64.6%) stddev-sans-first:3180.96 23:39:52 INFO - PROCESS | 1668 | Values: 1421.9 1567.7 1670.4 1742.7 2038.9 6732.7 8207.4 8209.3 8222.8 8606.8 8556.7 8624.7 8694.7 8704.3 8710.1 2416.4 2449.0 2450.1 2450.9 2454.0 1888.8 2189.1 2259.0 2260.0 2425.9 2228.8 2392.4 2482.9 2483.1 2488.4 2423.2 2448.5 2464.3 2465.3 2465.4 2137.0 2423.1 2461.3 2461.8 2464.4 8506.1 8822.6 8828.1 8828.8 8840.3 5203.9 5397.9 5403.6 5404.0 5408.7 3512.1 3536.5 3626.2 3636.1 3639.9 1011.5 1027.4 1031.2 1041.6 1043.3 11541.9 11681.7 11692.9 11702.9 11758.6 4663.8 4781.8 4814.9 4908.0 4950.0 10043.2 10057.5 10067.2 10084.1 10097.5 5391.8 5410.6 5417.6 5423.4 5439.4 4860.9 4931.8 4946.7 4960.6 4965.1 3098.4 3789.0 3805.1 3820.7 3959.7 1316.6 1368.5 1369.2 1381.4 1383.2 871.6 884.9 895.8 961.9 980.4 4732.0 5136.7 5962.0 5997.9 6093.8 948.3 986.4 990.2 1000.8 1021.9 3960.2 3965.3 3996.0 4084.3 4103.4 10501.7 10912.7 10936.6 10977.0 11072.9 10891.9 11003.8 11007.9 11036.4 11043.5 7785.9 8152.7 8304.3 8389.2 8437.2 5965.2 6059.8 6066.8 6135.4 6138.9 9983.3 9986.5 10003.9 10027.3 10049.6 8313.8 9806.3 9921.1 10229.1 10276.3 7522.1 7592.3 7660.6 7666.7 7672.3 7929.8 8189.3 8225.6 8313.8 8332.0 7347.3 7426.0 7452.4 7535.1 7609.2 7118.5 7148.1 7336.2 7351.4 7371.3 6893.1 6898.9 6981.9 6986.6 6987.3 4921.9 4941.1 5022.9 5060.2 5061.8 4215.2 4968.9 4982.3 5073.3 5159.1 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5124.08 Median:5839.14 stddev:1625.39 (27.8%) stddev-sans-first:1589.31 23:39:52 INFO - PROCESS | 1668 | Values: 311.5 322.4 331.8 333.3 333.8 5781.3 5976.9 5990.0 6040.5 6066.6 5695.6 5895.0 5960.6 5974.8 5996.5 4518.9 4551.5 4557.7 4569.9 4576.2 4300.4 4347.7 4473.4 4528.0 4585.6 3817.6 4061.3 4490.0 4494.2 4504.2 3657.4 3743.5 4492.2 4492.3 4543.3 3779.8 3910.5 3932.9 3933.9 3936.9 4629.8 4747.8 5703.3 5730.5 5741.8 5200.0 5246.8 5247.7 5255.3 5267.5 5896.6 6312.6 6332.7 6355.7 6370.3 3501.9 3823.0 3969.2 4085.0 4242.5 6712.4 6798.2 6801.5 6808.6 6812.7 3434.0 3588.3 4268.2 4310.3 4316.8 4363.9 4378.2 4381.7 4385.4 4393.2 5106.5 5116.2 5127.4 5133.0 5155.7 4710.8 5526.7 5863.7 6335.5 6589.5 1474.2 1488.2 1491.9 1493.4 1500.3 909.4 954.5 967.0 978.9 987.6 5850.9 5865.7 5936.6 5942.4 5983.6 5500.6 6076.9 6489.7 6500.6 6504.9 4495.0 5829.9 5865.3 5925.5 5963.7 3458.5 3466.7 3495.0 3508.5 3514.2 6287.9 6660.9 6877.0 6905.7 6911.2 6751.0 6771.5 6781.4 6787.9 6844.5 6019.2 6103.6 6563.8 6828.2 6867.2 6588.7 6610.9 6621.9 6631.6 6635.3 5166.5 6488.6 6529.2 6547.7 6565.5 6847.7 6891.1 6895.3 6905.7 6936.2 4263.8 4266.9 4274.5 4280.8 4283.6 6151.6 6291.3 6607.8 6611.9 6617.3 5304.1 5404.8 5788.7 6314.4 6412.3 6059.9 6388.7 6398.6 6399.4 6405.1 5153.8 5365.3 5848.4 6170.6 6277.8 5243.6 5279.3 6147.4 6235.3 6410.6 5445.9 6262.1 6274.0 6280.5 6282.8 23:39:52 INFO - PROCESS | 1668 | 23:39:52 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:16486.99 Median:571.56 stddev:22371.71 (3914.2%) stddev-sans-first:22402.79 23:39:52 INFO - PROCESS | 1668 | Values: 631.9 662.3 747.9 748.1 792.7 15024.9 15030.8 15275.5 15281.0 15289.3 13949.6 14031.5 14051.6 14051.9 14064.5 899.3 937.7 940.8 941.8 942.0 726.9 921.3 931.3 936.6 938.8 781.1 952.2 986.0 986.4 988.6 972.9 974.0 975.2 975.9 976.0 566.3 713.1 723.7 727.2 740.5 11507.1 13851.9 13889.0 13904.7 13923.9 12548.7 12688.4 12698.4 12781.0 13163.8 9792.0 9888.5 9937.3 10189.1 10365.7 3050.9 3442.1 3478.4 3488.9 3749.4 80878.0 81516.6 81816.0 81864.0 83015.6 9452.6 9752.0 9856.5 9875.9 10045.7 22382.3 22485.1 22485.8 22489.9 22500.3 7211.6 7257.2 7348.8 7418.4 7437.8 4002.2 4102.7 4105.9 4108.2 4219.2 3618.1 3685.2 3685.2 3690.0 3690.4 624.0 634.8 638.6 649.3 655.8 521.9 571.9 585.0 593.5 612.3 7637.7 7775.8 7870.6 7898.4 8149.9 546.7 564.5 571.2 587.4 595.3 3375.6 3451.6 3526.7 3760.9 3866.4 54781.6 74169.0 93447.1 94601.1 94814.0 55330.8 57405.4 64417.0 67254.3 68201.0 46654.8 46714.1 47748.0 49450.3 58321.1 7923.0 8116.8 8219.2 8272.5 8395.8 41120.0 41133.0 41234.4 41439.5 42399.8 56414.0 56957.0 57088.4 58033.4 58036.1 10590.2 10872.2 11113.4 11129.1 11370.8 11737.8 11972.9 11975.5 12171.9 12235.6 11266.1 11374.9 11464.1 11640.5 11736.5 9516.3 9592.3 10826.2 11206.4 11681.2 11211.2 11290.1 11360.8 11572.8 11576.2 9234.3 9393.7 9471.6 9775.0 10038.0 8898.3 9121.6 9379.3 9659.0 9718.7 23:39:52 INFO - PROCESS | 1668 | -------- Summary: end -------- 23:39:52 INFO - PROCESS | 1668 | 23:39:53 INFO - TEST-INFO | 1668: exit 0 23:39:53 INFO - TEST-OK | dromaeo_css | took 1115575ms 23:39:53 INFO - TEST-START | kraken 23:39:53 INFO - operating with platform_type : mac_ 23:39:53 INFO - Initialising browser for kraken test... 23:39:53 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpg7TLwj/profile http://localhost:49271/getInfo.html) 23:39:55 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 23:39:55 INFO - PROCESS | 1677 | colorDepth:24 23:39:55 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 23:39:55 INFO - PROCESS | 1677 | __metrics 23:39:55 INFO - PROCESS | 1677 | 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" 23:39:55 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:39:55 INFO - TEST-INFO | 1677: exit 0 23:39:55 INFO - Browser initialized. 23:39:55 INFO - Running cycle 1/1 for kraken test... 23:39:55 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpg7TLwj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:07 INFO - PROCESS | 1679 | RSS: Main: 239296512 23:40:07 INFO - PROCESS | 1679 | 23:40:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 23:40:11 INFO - PROCESS | 1679 | RSS: Main: 286720000 23:40:11 INFO - PROCESS | 1679 | 23:40:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 23:40:14 INFO - PROCESS | 1679 | RSS: Main: 299810816 23:40:14 INFO - PROCESS | 1679 | 23:40:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 23:40:18 INFO - PROCESS | 1679 | RSS: Main: 387100672 23:40:18 INFO - PROCESS | 1679 | 23:40:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 23:40:21 INFO - PROCESS | 1679 | RSS: Main: 286928896 23:40:21 INFO - PROCESS | 1679 | 23:40:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:40:24 INFO - PROCESS | 1679 | RSS: Main: 291655680 23:40:24 INFO - PROCESS | 1679 | 23:40:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 23:40:27 INFO - PROCESS | 1679 | RSS: Main: 328675328 23:40:27 INFO - PROCESS | 1679 | 23:40:30 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 23:40:30 INFO - PROCESS | 1679 | RSS: Main: 328826880 23:40:30 INFO - PROCESS | 1679 | 23:40:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 23:40:34 INFO - PROCESS | 1679 | RSS: Main: 328249344 23:40:34 INFO - PROCESS | 1679 | 23:40:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:40:36 INFO - PROCESS | 1679 | RSS: Main: 321511424 23:40:36 INFO - PROCESS | 1679 | 23:40:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:40:38 INFO - PROCESS | 1679 | RSS: Main: 328982528 23:40:38 INFO - PROCESS | 1679 | 23:40:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:40:41 INFO - PROCESS | 1679 | RSS: Main: 330170368 23:40:41 INFO - PROCESS | 1679 | 23:40:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:40:45 INFO - PROCESS | 1679 | RSS: Main: 335106048 23:40:45 INFO - PROCESS | 1679 | 23:40:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:40:48 INFO - PROCESS | 1679 | RSS: Main: 332918784 23:40:48 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 23:40:50 INFO - PROCESS | 1679 | RSS: Main: 397459456 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | __start_tp_report 23:40:50 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 23:40:50 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 23:40:50 INFO - PROCESS | 1679 | |i|pagename|runs| 23:40:50 INFO - PROCESS | 1679 | |0;ai-astar;113;116;109;112;112;111;112;111;104;121 23:40:50 INFO - PROCESS | 1679 | |1;audio-beat-detection;156;123;143;166;103;159;172;145;189;124 23:40:50 INFO - PROCESS | 1679 | |2;audio-dft;185;187;185;187;183;181;182;187;185;182 23:40:50 INFO - PROCESS | 1679 | |3;audio-fft;79;74;87;92;56;57;57;82;84;55 23:40:50 INFO - PROCESS | 1679 | |4;audio-oscillator;92;100;134;79;81;80;127;80;79;126 23:40:50 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;87;85;86;85;86;84;87;83;86;83 23:40:50 INFO - PROCESS | 1679 | |6;imaging-darkroom;91;92;92;92;91;92;92;93;92;92 23:40:50 INFO - PROCESS | 1679 | |7;imaging-desaturate;86;85;86;86;84;85;85;84;84;86 23:40:50 INFO - PROCESS | 1679 | |8;json-parse-financial;58;59;58;58;59;57;57;75;60;57 23:40:50 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;63;80;72;71;68;68;69;68;69 23:40:50 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;84;82;82;82;81;81;80;84;83 23:40:50 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;159;155;129;136;138;137;138;135;180;140 23:40:50 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;172;170;168;172;169;172;171;171;161;158 23:40:50 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;68;69;71;71;65 23:40:50 INFO - PROCESS | 1679 | __end_tp_report 23:40:50 INFO - PROCESS | 1679 | __start_cc_report 23:40:50 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,2014 23:40:50 INFO - PROCESS | 1679 | __end_cc_report 23:40:50 INFO - PROCESS | 1679 | __startTimestamp1461480050474__endTimestamp 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | ------- Summary: start ------- 23:40:50 INFO - PROCESS | 1679 | Number of tests: 14 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.38 (3.9%) stddev-sans-first:4.64 23:40:50 INFO - PROCESS | 1679 | Values: 113.0 116.0 109.0 112.0 112.0 111.0 112.0 111.0 104.0 121.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:157.50 stddev:25.88 (16.4%) stddev-sans-first:27.28 23:40:50 INFO - PROCESS | 1679 | Values: 156.0 123.0 143.0 166.0 103.0 159.0 172.0 145.0 189.0 124.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:2.27 (1.2%) stddev-sans-first:2.40 23:40:50 INFO - PROCESS | 1679 | Values: 185.0 187.0 185.0 187.0 183.0 181.0 182.0 187.0 185.0 182.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:72.30 Median:80.50 stddev:14.59 (18.1%) stddev-sans-first:15.27 23:40:50 INFO - PROCESS | 1679 | Values: 79.0 74.0 87.0 92.0 56.0 57.0 57.0 82.0 84.0 55.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:79.50 stddev:22.66 (28.5%) stddev-sans-first:23.93 23:40:50 INFO - PROCESS | 1679 | Values: 92.0 100.0 134.0 79.0 81.0 80.0 127.0 80.0 79.0 126.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.48 (1.7%) stddev-sans-first:1.41 23:40:50 INFO - PROCESS | 1679 | Values: 87.0 85.0 86.0 85.0 86.0 84.0 87.0 83.0 86.0 83.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:91.90 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:40:50 INFO - PROCESS | 1679 | Values: 91.0 92.0 92.0 92.0 91.0 92.0 92.0 93.0 92.0 92.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:0.88 (1.0%) stddev-sans-first:0.87 23:40:50 INFO - PROCESS | 1679 | Values: 86.0 85.0 86.0 86.0 84.0 85.0 85.0 84.0 84.0 86.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.50 stddev:5.43 (9.3%) stddev-sans-first:5.72 23:40:50 INFO - PROCESS | 1679 | Values: 58.0 59.0 58.0 58.0 59.0 57.0 57.0 75.0 60.0 57.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:4.82 (7.0%) stddev-sans-first:4.58 23:40:50 INFO - PROCESS | 1679 | Values: 63.0 63.0 80.0 72.0 71.0 68.0 68.0 69.0 68.0 69.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.32 (1.6%) stddev-sans-first:1.36 23:40:50 INFO - PROCESS | 1679 | Values: 83.0 84.0 82.0 82.0 82.0 81.0 81.0 80.0 84.0 83.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:139.00 stddev:15.43 (11.1%) stddev-sans-first:15.48 23:40:50 INFO - PROCESS | 1679 | Values: 159.0 155.0 129.0 136.0 138.0 137.0 138.0 135.0 180.0 140.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:171.00 stddev:4.93 (2.9%) stddev-sans-first:5.05 23:40:50 INFO - PROCESS | 1679 | Values: 172.0 170.0 168.0 172.0 169.0 172.0 171.0 171.0 161.0 158.0 23:40:50 INFO - PROCESS | 1679 | 23:40:50 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.80 23:40:50 INFO - PROCESS | 1679 | Values: 68.0 69.0 69.0 68.0 68.0 68.0 69.0 71.0 71.0 65.0 23:40:50 INFO - PROCESS | 1679 | -------- Summary: end -------- 23:40:50 INFO - PROCESS | 1679 | 23:40:51 INFO - TEST-INFO | 1679: exit 0 23:40:51 INFO - TEST-OK | kraken | took 58171ms 23:40:51 INFO - SUITE-END | took 1173s 23:40:51 INFO - Completed test suite (00:19:34) 23:40:51 INFO - javascript benchmark 23:40:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3211.4379983502886, 3436.31273745251, 3468.79187248765, 3470.791752494849, 3511.192425742079, 5589.7205139742955, 5659.886802263953, 5665.745041473133, 5666.235058267138, 5703.74333155008, 5634.3520495143075, 5693.373728889829, 5694.629849059808, 5697.373288938214, 5699.002674531951, 5152.948470515303, 5192.169252919533, 5213.113770658997, 5222.451642577532, 5287.894242115155, 5283.63014588977, 5283.63014588979, 5283.841484755444, 5285.524302812746, 5287.576993840503, 5183.818566350178, 5233.110371236899, 5238.7642556084875, 5247.186686063647, 5310.123829568117, 5134.9986752583445, 5175.197844334134, 5175.585953123741, 5180.559652429548, 5220.451852555465, 5112.590992720573, 5125.1287281162295, 5131.717755523445, 5150.665206761549, 5191.636585439021, 4619.653525985531, 5520.309961254843, 5523.7790488380415, 5562.471565201299, 5581.6371935824045, 6191.628502289832, 6240.4071613196675, 6240.469560087398, 6245.125682404467, 6254.0931564923285, 6093.68985668079, 6138.51101655979, 6214.316425193225, 6216.098665693495, 6246.219222597176, 5742.942570574324, 5783.392743761929, 5790.507806836424, 5797.768089276466, 5823.330317013513, 6241.812745617548, 6245.28179259391, 6250.749970001149, 6255.624662520263, 6259.311475737665, 5999.040153575407, 6063.696305294383, 6122.877542449215, 6164.291106522717, 6183.598066125687, 6199.535034872312, 6206.72069756862, 6225.750969961151, 6251.281102673251, 6262.46769024638, 6181.320054793969, 6216.875662486816, 6222.471089957405, 6235.875282494416, 6268.341824108494, 6098.462484929982, 6187.381261873867, 6191.907121393183, 6204.658743769046, 6236.532260080512, 4907.70553766768, 4908.828191013369, 4943.703377797344, 4950.3069570260195, 4986.825461108844, 4400.69195156336, 4422.75674837887, 4424.911501769947, 4429.136318417942, 4468.843590474317, 5679.829605111853, 5682.374938756733, 5694.145878118233, 5715.113722668542, 5770.24986751728, 6070.514358851281, 6127.448529632355, 6181.0, 6191.659458729723, 6194.194754681863, 5652.463016013472, 5664.830055098354, 5683.147527870852, 5696.430356964271, 5715.8856822864145, 5368.32895888014, 5382.165764306539, 5389.568834493231, 5390.326209223847, 5395.163749618815, 5377.516023557899, 6153.784617538454, 6303.747850086037, 6324.30432652417, 6339.366063393623, 4725.40932383452, 6151.507879369729, 6194.938050619617, 6234.501239900887, 6243.406876346739, 6226.439620434183, 6289.779857705142, 6298.779542716166, 6303.9684801575695, 6315.778947736807, 6139.0, 6183.288921773874, 6191.752329906753, 6196.81409557714, 6221.253449586078, 5430.972845135749, 6205.720742566505, 6208.379162083756, 6226.283977342664, 6239.937600623935, 5937.643741375531, 6048.697565121638, 6120.0, 6138.785142519991, 6139.4781443577795, 4964.851054468371, 6084.056971169476, 6095.529019716752, 6105.84735381619, 6144.631322120687, 5900.291964964232, 5934.584579079596, 5963.7912673056235, 5965.731542080704, 5985.730642121202, 5884.47039766423, 6026.246719160105, 6118.449339559461, 6119.3268740437625, 6121.693915304306, 5767.509761670305, 5831.912521312269, 5842.152887831326, 5885.08781138907, 5961.642301461753], "value": 5660.219949106775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.3026822984281, 526.7576914619275, 537.0279793573629, 541.9756110975005, 573.1345668041258, 30229.546556801666, 30976.845115774446, 30986.845065774694, 30987.535186972185, 31017.844910775442, 31309.0, 31780.68219317806, 39314.60685393145, 40728.185436291256, 40807.59192408075, 9406.811863762738, 9627.566759495805, 9640.951795241013, 9647.614095436174, 9666.565004574775, 8294.087650358486, 8544.18830211129, 9440.103190196955, 9647.131758141766, 9662.710118696416, 8698.826023479527, 9256.72229833106, 9341.53292335384, 11341.829872551918, 11726.882731172707, 11341.603043893425, 11464.885351146508, 11465.942670286679, 11466.942665286704, 11474.368909710047, 8448.23965843071, 9337.953310233406, 11335.773284534345, 11478.426078696031, 11604.883951160466, 38391.61608383936, 38905.80547097247, 38933.805330973446, 38973.02567435808, 38984.41523377151, 3283.1956170738085, 3293.5718356613725, 3343.0, 3484.8083355415442, 3640.0535860676414, 27437.58843617347, 28008.299792505146, 28098.578521322197, 28296.292592685142, 28344.433111337865, 2719.1978366381963, 2748.1618106477517, 2803.4533266013136, 2810.3676672748675, 2864.5273529867545, 495908.0, 502488.0, 504461.0, 506265.46867265797, 507780.0, 61413.38586614166, 62402.37597624057, 62426.37573624206, 62490.375096249365, 62513.0, 65653.67173164104, 65886.0117098244, 65970.67014664992, 65996.68006639936, 66066.0090098649, 16114.75827862583, 16726.330946762235, 16729.079900605582, 16730.0, 16754.581135471468, 12288.815667764991, 12290.139690221777, 12311.322877241837, 12317.199382040139, 12327.321997290055, 14777.335019924129, 15281.38874445032, 16449.506514804576, 16641.750373744162, 17033.48899533016, 5982.611130276605, 6180.907286390708, 6197.566170368121, 6229.345918678564, 6232.8130156095385, 975.6146322202832, 980.2011360740973, 992.0525897767615, 1010.939343639384, 1027.5889644142253, 27008.0, 28497.71502284992, 28926.276843079093, 29418.558721619193, 29676.258093547403, 1115.9609413670646, 1165.3532289579196, 1179.2511755035443, 1192.701824543864, 1232.4761976160096, 15125.319360628799, 15217.543473695807, 15331.310091045707, 15349.783567054388, 15411.537653870178, 616167.0, 621168.8941555263, 624632.0, 625058.0, 626011.8699406474, 58536.707316463995, 60514.69742651346, 60592.0, 60723.69638151869, 60817.0, 1465.465105236581, 1475.6974820162056, 1486.851314868526, 1489.8063251777417, 1493.5967288831955, 23949.657046077045, 28782.712172878004, 29188.0, 29706.0, 29720.702792972657, 51761.0, 52019.0, 52412.73793631008, 52417.0, 52530.73734631302, 547128.0, 548010.0, 550602.0, 551114.0, 552775.0, 26298.21105366842, 26739.86630066837, 27147.86426067857, 27191.59212611852, 36218.09454763652, 36380.0, 37944.620553794106, 40168.59831401648, 47290.344837930505, 47968.760156198994, 28194.718052819208, 35743.46384804282, 36525.0494445843, 36940.0, 37117.81441092777, 35890.32486545069, 35957.741479048105, 36595.90212293636, 36759.0, 37046.0, 36270.09324766902, 36346.63653363432, 36528.45207321946, 36734.081647959014, 37034.0, 31561.526577100904, 32021.8775575383, 32280.192995175308, 32360.676393235768, 32416.0, 23902.88048559746, 24102.39744006414, 24195.395115122265, 24472.265832025067, 24527.632085518373], "value": 19512.738655082303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.50701721977305, 398.9401589761537, 400.7745088097963, 404.65604236399054, 411.5760766410596, 14942.551723448314, 17024.574385640364, 17255.91372043141, 20247.493812654673, 20278.49303767405, 16018.19909004551, 16644.750328745078, 19865.404037878852, 20560.897195514, 20796.792032079673, 5895.941040589592, 6061.818145455643, 6112.144299798032, 6117.44942955134, 6133.2946711128125, 5872.236609240793, 5979.342272350038, 5980.970095149518, 6090.878182436349, 6108.175396321484, 6041.577089603729, 6062.03007518797, 6066.241719785027, 6072.05883088122, 6090.0816242883575, 5810.360860305363, 6088.299845517778, 6099.420555047263, 6102.237220347457, 6111.388861113897, 5298.390685071227, 5305.495977882095, 5322.441143679896, 5331.0, 5335.33308336458, 18135.546611334692, 25173.748262517507, 26380.60429093565, 26559.60160597573, 26583.73416265832, 2278.236790675126, 2435.866027368494, 2567.281161274846, 2588.171785028773, 2744.8353098813936, 14793.630159246104, 14802.925985370004, 15037.323320450607, 15052.623684407868, 15058.247087645683, 1688.814230434651, 1704.6846333428355, 1743.3985275080076, 1758.8944663320115, 1807.0, 100257.49871250597, 101984.49007754914, 103953.96046039595, 106076.0, 108215.45892270567, 11273.267237629529, 11352.943235283936, 11368.602098926498, 11419.143564232716, 11551.884481155248, 14648.414063437556, 14733.92633036828, 14767.778483322758, 14782.334794934253, 14800.703985920221, 7005.299470052954, 7373.963130184315, 8570.571471426403, 8693.000304964884, 8749.650013999497, 6944.51388402807, 8547.40168188221, 8578.313734901192, 8660.653573857102, 8682.86975695365, 4511.1654343946475, 4566.1552612766745, 4568.33759104928, 4627.120847039119, 4672.322513235562, 1879.4494542002628, 1900.8669393142347, 1943.3004118517322, 1956.6575849226613, 1998.490384951828, 771.248033167657, 775.3525805952094, 797.8204903896693, 915.0894859614726, 962.5379817687549, 19631.509212269808, 20448.38654840357, 20501.58996820085, 20573.0, 20945.89527052355, 874.8932600260675, 958.990410095904, 977.0913050862766, 1042.551702767802, 1063.2079101069598, 8261.958690206631, 10472.842907356397, 10566.049055585034, 10620.840687389695, 10643.84034239487, 581685.0, 584007.0, 591270.0, 607372.0, 612619.0, 124876.1268580972, 133605.0, 134505.0, 136390.31804840913, 143730.0, 883.2580632268925, 1009.4404145595073, 1086.2721976275757, 1086.7337502311825, 1099.142668718401, 17713.822861771216, 18646.44060678182, 18665.88004719721, 18837.529061773566, 18845.057747112314, 39422.21155576815, 40750.0, 52400.68998274921, 52445.47554524406, 53068.0, 65145.67427162834, 65694.67152664207, 65718.0, 66671.66664166842, 68449.65775171093, 6762.222344430454, 7866.803329916798, 8027.478213916077, 8041.959790201012, 8488.660453581788, 9296.256299495888, 12052.0, 12247.877521224673, 12567.434465448894, 12699.603043665375, 10687.358758474516, 10884.129269658566, 10958.397288149228, 11041.503132359223, 11044.392558409365, 10621.468926553487, 10833.0, 10835.133189344991, 10835.404052776857, 11329.71675708114, 10825.809160992441, 11238.381888996184, 11317.377544234816, 11348.829767553329, 11415.714607134556, 7772.378209743094, 8003.19968003195, 8170.877436838571, 8346.958265208636, 8419.579021049045, 8964.238039766693, 10128.240381971234, 10314.27800053989, 10538.051575358255, 11026.503807328529], "value": 9457.184761525945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.8791402730767, 1567.686462707458, 1670.4320531019453, 1742.668892910347, 2038.867473614215, 6732.73069077237, 8207.425480216387, 8209.302209312209, 8222.753317400488, 8606.827863442742, 8556.74329770108, 8624.69813556524, 8694.695685651004, 8704.303655707545, 8710.128987101287, 2416.3596646888545, 2448.9510209795794, 2450.0567281596536, 2450.901963921441, 2454.0, 1888.7827899791494, 2189.1462329691435, 2258.977410225893, 2259.9943025353723, 2425.9393515162087, 2228.843980921336, 2392.437777122375, 2482.9199298305207, 2483.0688491815567, 2488.4276616378243, 2423.212455951805, 2448.5470188015183, 2464.322311364389, 2465.3343597228827, 2465.395977985387, 2136.9786302136936, 2423.09134074722, 2461.3477428481465, 2461.8276720629565, 2464.408541949937, 8506.064332923374, 8822.558872056436, 8828.07305232954, 8828.779280517974, 8840.292776577922, 5203.869903252411, 5397.919031214535, 5403.621746477709, 5404.000259951921, 5408.702521361323, 3512.051746028558, 3536.469529570585, 3626.165981824195, 3636.127329440915, 3639.854405823764, 1011.4841430870309, 1027.3733022856127, 1031.2214278219897, 1041.5989843910074, 1043.2697112021615, 11541.884581154165, 11681.707957301136, 11692.88307116935, 11702.941485292604, 11758.58844940423, 4663.790129444184, 4781.7740166117865, 4814.8796280093275, 4907.975460122748, 4949.975250123798, 10043.246756493292, 10057.497125143713, 10067.194624430029, 10084.142847858015, 10097.495125243708, 5391.81128660495, 5410.567154627621, 5417.59368047398, 5423.403425623178, 5439.4288599696465, 4860.878478038077, 4931.827386041471, 4946.678465899705, 4960.603151747851, 4965.131102057126, 3098.4267910436192, 3788.981055094762, 3805.1438426354403, 3820.67524260441, 3959.7228194026716, 1316.5984374765787, 1368.548379034916, 1369.1990185741454, 1381.405995421978, 1383.2392184298596, 871.6469829718848, 884.8893888263967, 895.7984453497911, 961.9470929098827, 980.426070240814, 4731.976340118346, 5136.666116702402, 5961.986462301419, 5997.880042399128, 6093.756249750049, 948.3361646847235, 986.3539381704994, 990.1682586627268, 1000.8198524265703, 1021.9386836789816, 3960.2277555876326, 3965.266425711195, 3996.0, 4084.326086195744, 4103.4460347853255, 10501.684949451528, 10912.672619821418, 10936.617218397318, 10977.0, 11072.944635276934, 10891.891081089088, 11003.834942475869, 11007.889921100686, 11036.448177591248, 11043.503042363112, 7785.883211751715, 8152.673893044212, 8304.335653147855, 8389.203025712548, 8437.240648341678, 5965.194698715618, 6059.7612338574745, 6066.817995460143, 6135.355787642234, 6138.877222455615, 9983.301168918106, 9986.500674966368, 10003.94958529373, 10027.348222365523, 10049.598016079568, 8313.792155196168, 9806.313558050868, 9921.107100361001, 10229.130523905551, 10276.332038417479, 7522.097348318018, 7592.278733520307, 7660.578668173304, 7666.731664391719, 7672.271134242238, 7929.770885512755, 8189.262966333059, 8225.642768943297, 8313.750587482386, 8331.95834020826, 7347.338739513256, 7425.997490338735, 7452.441066920112, 7535.13345965221, 7609.162992070757, 7118.5017048806085, 7148.070750802362, 7336.193018768038, 7351.448641351813, 7371.262873712586, 6893.138357705287, 6898.8620227596175, 6981.895271570829, 6986.580805151707, 6987.301269873175, 4921.876953076202, 4941.061198372297, 5022.874428139326, 5060.240963855451, 5061.797528098835, 4215.156968606352, 4968.925466117938, 4982.252662100714, 5073.289739436408, 5159.071367153798], "value": 4614.501373232523, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.48604802076557, 322.36976710530917, 331.8390580568425, 333.2568372529261, 333.8380885270643, 5781.277340332458, 5976.910346344803, 5989.98170311047, 6040.516758659308, 6066.636001839893, 5695.572832037593, 5894.999999999989, 5960.642361458305, 5974.761009559613, 5996.52027837773, 4518.909621807562, 4551.542167229692, 4557.701055199269, 4569.885752856188, 4576.153411618861, 4300.419443375151, 4347.673924455663, 4473.418455600768, 4528.0, 4585.564371384713, 3817.618238176188, 4061.294256412299, 4490.0, 4494.1910456117885, 4504.234280172363, 3657.359962006665, 3743.47591337213, 4492.236319825637, 4492.326151077348, 4543.295789152687, 3779.7543159694533, 3910.4720862683457, 3932.8791294480934, 3933.940990885139, 3936.881893543198, 4629.8148074077, 4747.83677998889, 5703.3441154267375, 5730.484256416901, 5741.827745167651, 5200.037992971313, 5246.816361427332, 5247.685138891678, 5255.290535777659, 5267.525922666979, 5896.587238893279, 6312.621242725451, 6332.715027823759, 6355.745770169187, 6370.267419246799, 3501.929961400783, 3822.9869084692577, 3969.2260009298197, 4085.0400155963325, 4242.5121111072, 6712.362325579111, 6798.184217893835, 6801.5238933274195, 6808.5914845109455, 6812.6934287957165, 3433.9656603433646, 3588.2861238618425, 4268.189044081614, 4310.267254566731, 4316.827326906889, 4363.934540981888, 4378.2119218540965, 4381.7370957742, 4385.364122202327, 4393.154874952527, 5106.514881086365, 5116.158183054097, 5127.410502744086, 5133.024725302255, 5155.716435596003, 4710.764461776897, 5526.696031718294, 5863.736131874076, 6335.493160547145, 6589.538732288694, 1474.1523623916291, 1488.1740633948045, 1491.940322387114, 1493.3951749541236, 1500.2798656644873, 909.4361495872602, 954.4604172467274, 967.0184762466102, 978.9070038346346, 987.6345752071636, 5850.8537286567325, 5865.677387743715, 5936.5547583931375, 5942.376050514634, 5983.61106528083, 5500.614956952975, 6076.900780601924, 6489.67551622417, 6500.609963402211, 6504.869902601921, 4494.955050449519, 5829.863176680591, 5865.325487568899, 5925.48167029011, 5963.701814909324, 3458.515807786912, 3466.7399945004227, 3494.965050349515, 3508.5088087667746, 3514.2444374459615, 6287.9056814147825, 6660.8667826643195, 6877.0, 6905.654717264117, 6911.239763626098, 6750.966245168743, 6771.492138089663, 6781.355771201728, 6787.864242715118, 6844.452443804484, 6019.217501724747, 6103.579498156726, 6563.785699645486, 6828.180618325832, 6867.175938887365, 6588.736450541925, 6610.867782644416, 6621.867562648624, 6631.574211544541, 6635.303293154149, 5166.509181627739, 6488.631649448012, 6529.204468770936, 6547.738090476328, 6565.507586931095, 6847.726090956506, 6891.138607674041, 6895.275996020346, 6905.721112033118, 6936.237013928363, 4263.786810659517, 4266.87199384019, 4274.487061552633, 4280.764557949343, 4283.593058659422, 6151.630902145886, 6291.276503202191, 6607.768728094494, 6611.900821487778, 6617.305182955913, 5304.098303288527, 5404.756785944721, 5788.739506722123, 6314.431701146918, 6412.2625898022325, 6059.909101363572, 6388.712507937061, 6398.648074355955, 6399.360063993563, 6405.135306733718, 5153.845384638467, 5365.302510673588, 5848.4151584841175, 6170.629762214281, 6277.780277690259, 5243.606729495227, 5279.313689220377, 6147.354527774698, 6235.314115447388, 6410.61536307823, 5445.945540544544, 6262.09199666055, 6273.96863015682, 6280.497560195082, 6282.811515654537], "value": 4599.491063855574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.9210098737658, 662.2946561911565, 747.9027726395568, 748.0761259844091, 792.6591565626778, 15024.924875375622, 15030.77453838192, 15275.541733747978, 15281.00673456226, 15289.311980960856, 13949.58151255464, 14031.5088971886, 14051.578452646438, 14051.859481405183, 14064.507742228998, 899.2985471332371, 937.7374335186158, 940.8447606144978, 941.8398872191743, 942.0344147249056, 726.9091363579553, 921.262989608314, 931.2922179143832, 936.5551363102539, 938.7653086728318, 781.0510230070463, 952.1906379577339, 985.9901400986006, 986.3933680786337, 988.6342053440237, 972.8978457261992, 973.9724590556959, 975.2441857560376, 975.9072888075622, 976.0288512929645, 566.3119310038282, 713.1442269276888, 723.7358364197083, 727.1928159742681, 740.4779630360637, 11507.136964727679, 13851.930740346335, 13889.0, 13904.721905561933, 13923.930380348134, 12548.74902501954, 12688.365581720876, 12698.42857071434, 12781.0, 13163.802542961768, 9791.951040244825, 9888.505574721306, 9937.304388692723, 10189.082982531534, 10365.689029329056, 3050.923726906823, 3442.087846720621, 3478.4086705260165, 3488.8778892738887, 3749.4000959846567, 80878.0, 81516.59241703754, 81816.0, 81864.0, 83015.5849220756, 9452.64504484846, 9751.951240243754, 9856.457894815854, 9875.851862222073, 10045.748856278506, 22382.32853014412, 22485.100595976306, 22485.775142248367, 22489.88755056247, 22500.32499025032, 7211.603361815046, 7257.237990011078, 7348.816279592946, 7418.369438597671, 7437.776866694008, 4002.1649428226615, 4102.712810103324, 4105.904288377875, 4108.219438306772, 4219.198352313112, 3618.1135621772833, 3685.207680348738, 3685.207680348738, 3690.0, 3690.3541880170865, 623.9844003899939, 634.7556190866458, 638.6455517188006, 649.2695717318018, 655.7737031750656, 521.9269302297681, 571.928508936383, 584.9824505264849, 593.4925638579039, 612.2713970375239, 7637.732679356196, 7775.844483110306, 7870.606469676493, 7898.407619428566, 8149.877751833727, 546.7348336057009, 564.5032371513042, 571.1889117453227, 587.4301927130676, 595.3094410483818, 3375.561177046968, 3451.620321764604, 3526.682598566141, 3760.8683696070507, 3866.439366291872, 54781.63045923884, 74169.0, 93447.06552934383, 94601.05398945922, 94814.0, 55330.786768529615, 57405.42594574084, 64417.0, 67254.32745672579, 68201.0, 46654.766726166155, 46714.06571868544, 47748.0, 49450.25824612706, 58321.12518312228, 7923.0, 8116.75649730509, 8219.219174178443, 8272.545010024507, 8395.790105247417, 41120.0, 41133.0, 41234.38148427716, 41439.54961576451, 42399.788001059795, 56414.0, 56957.0, 57088.42911570997, 58033.4196658028, 58036.129458059004, 10590.205734569783, 10872.184586156229, 11113.444327783416, 11129.054030407506, 11370.772584548427, 11737.823932640846, 11972.880271197177, 11975.461104250504, 12171.878281217074, 12235.632931012084, 11266.098712103176, 11374.94312528432, 11464.082873370277, 11640.476178571815, 11736.471858766547, 9516.33385662997, 9592.280578956466, 10826.242163048511, 11206.38364889939, 11681.240719353214, 11211.215214934877, 11290.096792256763, 11360.772784544097, 11572.826407603725, 11576.24754390962, 9234.307426942873, 9393.701803312888, 9471.621135154517, 9775.0, 10037.996200380196, 8898.288136948899, 9121.589528471368, 9379.343445958717, 9659.034096590285, 9718.70843874685], "value": 6671.900061274874, "unit": "score"}], "name": "dromaeo_css", "value": 7272.319526351111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 112.0, 112.0, 111.0, 112.0, 111.0, 104.0, 121.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 143.0, 166.0, 103.0, 159.0, 172.0, 145.0, 189.0, 124.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 185.0, 187.0, 183.0, 181.0, 182.0, 187.0, 185.0, 182.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 87.0, 92.0, 56.0, 57.0, 57.0, 82.0, 84.0, 55.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 100.0, 134.0, 79.0, 81.0, 80.0, 127.0, 80.0, 79.0, 126.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 85.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 92.0, 91.0, 92.0, 92.0, 93.0, 92.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 86.0, 84.0, 85.0, 85.0, 84.0, 84.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 57.0, 57.0, 75.0, 60.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 80.0, 72.0, 71.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 82.0, 82.0, 81.0, 81.0, 80.0, 84.0, 83.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 129.0, 136.0, 138.0, 137.0, 138.0, 135.0, 180.0, 140.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 168.0, 172.0, 169.0, 172.0, 171.0, 171.0, 161.0, 158.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 71.0, 71.0, 65.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1469.6, "alertThreshold": 2.0}]} 23:40:51 INFO - Return code: 0 23:40:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:40:51 ERROR - # TBPL SUCCESS # 23:40:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:40:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:40:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:40:51 INFO - 2016-04-23 23:40:51.787 screenresolution[1683:11496] starting screenresolution argv=screenresolution get 23:40:51 INFO - 2016-04-23 23:40:51.790 screenresolution[1683:11496] Display 0: 1600x1200x32@60 23:40:51 INFO - 2016-04-23 23:40:51.795 screenresolution[1684:11499] starting screenresolution argv=screenresolution list 23:40:51 INFO - Available Modes on Display 0 23:40:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:40:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:40:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:40:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:40:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:40:52 INFO - Intel Iris: 23:40:52 INFO - Chipset Model: Intel Iris 23:40:52 INFO - Type: GPU 23:40:52 INFO - Bus: Built-In 23:40:52 INFO - VRAM (Dynamic, Max): 1536 MB 23:40:52 INFO - Vendor: Intel (0x8086) 23:40:52 INFO - Device ID: 0x0a2e 23:40:52 INFO - Revision ID: 0x0009 23:40:52 INFO - Displays: 23:40:52 INFO - Display: 23:40:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:40:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:40:52 INFO - Display Serial Number: 1600x1200 60 23:40:52 INFO - Main Display: Yes 23:40:52 INFO - Mirror: Off 23:40:52 INFO - Online: Yes 23:40:52 INFO - Rotation: Supported 23:40:52 INFO - Return code: 0 23:40:52 INFO - Running post-action listener: _resource_record_post_action 23:40:52 INFO - Running post-run listener: _resource_record_post_run 23:40:53 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32493056; Write bytes: 696793600; Read time: 326; Write time: 1975 23:40:53 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 388676096; Write bytes: 383051776; Read time: 28586; Write time: 755 23:40:53 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 30711296; Write bytes: 298144256; Read time: 306; Write time: 1183 23:40:53 INFO - Running post-run listener: _upload_blobber_files 23:40:53 INFO - Blob upload gear active. 23:40:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:40:53 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 23:40:53 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:40:53 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:40:53 INFO - (blobuploader) - INFO - Open directory for files ... 23:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:54 INFO - (blobuploader) - INFO - Done attempting. 23:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:55 INFO - (blobuploader) - INFO - Done attempting. 23:40:55 INFO - (blobuploader) - INFO - Iteration through files over. 23:40:55 INFO - Return code: 0 23:40:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:40:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:40:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/907e79c8600c964f176b829f3ef0ed28489fcf78a4e733fa7b812f5fe99ae7a1b81f45cbbc8f524638c086c6d478dace71616ab2752b416c16092fbc86699eb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439673821eb4d12fba4795a0c2b855ffae2462c2aa2211fc8a6ad69999901312061d9092ac03c68b5f7618dc4cabb455a84437f410372f0de17a00e32dd6ced3"} 23:40:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:40:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:40:55 INFO - Contents: 23:40:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/907e79c8600c964f176b829f3ef0ed28489fcf78a4e733fa7b812f5fe99ae7a1b81f45cbbc8f524638c086c6d478dace71616ab2752b416c16092fbc86699eb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439673821eb4d12fba4795a0c2b855ffae2462c2aa2211fc8a6ad69999901312061d9092ac03c68b5f7618dc4cabb455a84437f410372f0de17a00e32dd6ced3"} 23:40:55 INFO - Running post-run listener: copy_logs_to_upload_dir 23:40:55 INFO - Copying logs to upload dir... 23:40:55 INFO - mkdir: /builds/slave/test/build/upload/logs 23:40:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.192375 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-04-23 23:40:55.939486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:55.943812) ========= 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.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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/Fx-Team/sha512/907e79c8600c964f176b829f3ef0ed28489fcf78a4e733fa7b812f5fe99ae7a1b81f45cbbc8f524638c086c6d478dace71616ab2752b416c16092fbc86699eb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439673821eb4d12fba4795a0c2b855ffae2462c2aa2211fc8a6ad69999901312061d9092ac03c68b5f7618dc4cabb455a84437f410372f0de17a00e32dd6ced3"} build_url:https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010653 build_url: 'https://queue.taskcluster.net/v1/task/MpFeUWNbSiS7phMYpqA8UQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/907e79c8600c964f176b829f3ef0ed28489fcf78a4e733fa7b812f5fe99ae7a1b81f45cbbc8f524638c086c6d478dace71616ab2752b416c16092fbc86699eb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/439673821eb4d12fba4795a0c2b855ffae2462c2aa2211fc8a6ad69999901312061d9092ac03c68b5f7618dc4cabb455a84437f410372f0de17a00e32dd6ced3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:55.976012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:55.976326) ========= 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.mhsXlbBGrR/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.9o4m28sDoI/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005237 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:40:56.024982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:40:56.025283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:40:56.028657) ========= ========= Total master_lag: 0.28 =========