builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1461426762.36 results: success (0) buildid: 20160423070820 builduid: 0b589bb5cc7c4e91b12de30e70fdb2dc revision: 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:42.362842) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:42.363224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:42.363515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:42.398032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-23 08:52:42.398346) ========= 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.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-23 08:52:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 58.8M=0s 2016-04-23 08:52:42 (58.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083887 ========= master_lag: 4.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-23 08:52:47.300373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:47.300675) ========= 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.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020033 ========= master_lag: 0.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:47.752462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-23 08:52:47.752822) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b --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 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-23 08:52:47,845 truncating revision to first 12 chars 2016-04-23 08:52:47,845 Setting DEBUG logging. 2016-04-23 08:52:47,845 attempt 1/10 2016-04-23 08:52:47,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81e5bf11a1e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 08:52:48,496 unpacking tar archive at: fx-team-81e5bf11a1e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899844 ========= master_lag: 3.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-23 08:52:52.456511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:52.456785) ========= script_repo_revision: 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 08:52:52.457185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-04-23 08:52:52.457545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-04-23 08:52:57.959329) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-23 08:52:57.959687) ========= /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.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:52:58 INFO - MultiFileLogger online at 20160423 08:52:58 in /builds/slave/test 08:52:58 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 08:52:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:58 INFO - {'append_to_log': False, 08:52:58 INFO - 'base_work_dir': '/builds/slave/test', 08:52:58 INFO - 'blob_upload_branch': 'Fx-Team', 08:52:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:58 INFO - 'branch': 'Fx-Team', 08:52:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:58 INFO - 'config_files': ('talos/mac_config.py',), 08:52:58 INFO - 'default_actions': ('clobber', 08:52:58 INFO - 'read-buildbot-config', 08:52:58 INFO - 'download-and-extract', 08:52:58 INFO - 'populate-webroot', 08:52:58 INFO - 'create-virtualenv', 08:52:58 INFO - 'install', 08:52:58 INFO - 'run-tests'), 08:52:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:58 INFO - 'download_minidump_stackwalk': True, 08:52:58 INFO - 'download_symbols': 'ondemand', 08:52:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:58 INFO - 'installer_path': 'installer.exe', 08:52:58 INFO - 'log_level': 'info', 08:52:58 INFO - 'log_name': 'talos', 08:52:58 INFO - 'log_to_console': True, 08:52:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:58 INFO - 'opt_config_files': (), 08:52:58 INFO - 'pip_index': False, 08:52:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:58 INFO - 'cmd': ('bash', 08:52:58 INFO - '-c', 08:52:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:58 INFO - 'enabled': True, 08:52:58 INFO - 'halt_on_failure': False, 08:52:58 INFO - 'name': 'check_screen_resolution'},), 08:52:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:58 INFO - 'cmd': ('bash', 08:52:58 INFO - '-c', 08:52:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:58 INFO - 'enabled': True, 08:52:58 INFO - 'halt_on_failure': False, 08:52:58 INFO - 'name': 'check_screen_resolution'},), 08:52:58 INFO - 'run_cmd_checks_enabled': True, 08:52:58 INFO - 'sps_profile': False, 08:52:58 INFO - 'sps_profile_interval': 0, 08:52:58 INFO - 'suite': 'dromaeojs', 08:52:58 INFO - 'system_bits': '32', 08:52:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:58 INFO - 'title': 't-yosemite-r7-0100', 08:52:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:58 INFO - 'use_talos_json': True, 08:52:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:58 INFO - 'work_dir': 'build'} 08:52:58 INFO - ##### 08:52:58 INFO - ##### Running clobber step. 08:52:58 INFO - ##### 08:52:58 INFO - Running pre-action listener: _resource_record_pre_action 08:52:58 INFO - Running main action method: clobber 08:52:58 INFO - rmtree: /builds/slave/test/build 08:52:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:59 INFO - Running post-action listener: _resource_record_post_action 08:52:59 INFO - ##### 08:52:59 INFO - ##### Running read-buildbot-config step. 08:52:59 INFO - ##### 08:52:59 INFO - Running pre-action listener: _resource_record_pre_action 08:52:59 INFO - Running main action method: read_buildbot_config 08:52:59 INFO - Using buildbot properties: 08:52:59 INFO - { 08:52:59 INFO - "project": "", 08:52:59 INFO - "product": "firefox", 08:52:59 INFO - "script_repo_revision": "production", 08:52:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:52:59 INFO - "repository": "", 08:52:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:52:59 INFO - "buildid": "20160423070820", 08:52:59 INFO - "pgo_build": "False", 08:52:59 INFO - "basedir": "/builds/slave/test", 08:52:59 INFO - "buildnumber": 709, 08:52:59 INFO - "slavename": "t-yosemite-r7-0100", 08:52:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:52:59 INFO - "platform": "yosemite_r7", 08:52:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:52:59 INFO - "branch": "fx-team", 08:52:59 INFO - "repo_path": "integration/fx-team", 08:52:59 INFO - "revision": "81e5bf11a1e69b4748d11854bdbb0f4195edcb7b", 08:52:59 INFO - "stage_platform": "macosx64", 08:52:59 INFO - "builduid": "0b589bb5cc7c4e91b12de30e70fdb2dc", 08:52:59 INFO - "slavebuilddir": "test" 08:52:59 INFO - } 08:52:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:52:59 INFO - Running post-action listener: _resource_record_post_action 08:52:59 INFO - ##### 08:52:59 INFO - ##### Running download-and-extract step. 08:52:59 INFO - ##### 08:52:59 INFO - Running pre-action listener: _resource_record_pre_action 08:52:59 INFO - Running main action method: download_and_extract 08:52:59 INFO - mkdir: /builds/slave/test/build/tests 08:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:59 INFO - https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:52:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:52:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:52:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:01 INFO - Downloaded 1199 bytes. 08:53:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:53:01 INFO - Using the following test package requirements: 08:53:01 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:53:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:53:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:53:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'jsshell-mac.zip'], 08:53:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:53:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:53:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:53:01 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:53:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:53:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:53:01 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:53:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:53:01 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')]} 08:53:01 INFO - https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:02 INFO - Downloaded 18109585 bytes. 08:53:02 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'] 08:53:02 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 08:53:05 INFO - Return code: 0 08:53:05 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 08:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:05 INFO - https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:53:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:53:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:53:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:06 INFO - Downloaded 18109585 bytes. 08:53:06 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'] 08:53:06 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 08:53:10 INFO - Return code: 0 08:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:10 INFO - https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:11 INFO - Downloaded 10840145 bytes. 08:53:11 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'] 08:53:11 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 08:53:11 INFO - Return code: 0 08:53: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')]} 08:53:11 INFO - https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DSHxp28_TVC43EdzwYltKA/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 08:53:14 INFO - Downloaded 110124604 bytes. 08:53:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:53:14 INFO - mkdir: /builds/slave/test/properties 08:53:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:14 INFO - Contents: 08:53:14 INFO - build_url:https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - Running post-action listener: set_extra_try_arguments 08:53:15 INFO - ##### 08:53:15 INFO - ##### Running populate-webroot step. 08:53:15 INFO - ##### 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: populate_webroot 08:53:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:15 INFO - '--tppagecycles', 08:53:15 INFO - '7'], 08:53:15 INFO - 'tests': ['tsvgm']}}, 08:53:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart']}, 08:53:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart']}, 08:53:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o']}, 08:53:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['tp5o']}, 08:53:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s', 08:53:15 INFO - '--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}, 08:53:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}}, 08:53:15 INFO - 'talos.zip': {'path': '', 08:53:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - ##### 08:53:15 INFO - ##### Running create-virtualenv step. 08:53:15 INFO - ##### 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: create_virtualenv 08:53:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:15 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 08:53:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:15 INFO - Using real prefix '/tools/python27' 08:53:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:19 INFO - Installing pip.................done. 08:53:19 INFO - Return code: 0 08:53:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53: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', 'pip>=1.5'] in /builds/slave/test/build 08:53: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 pip>=1.5 08:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:19 INFO - 'HOME': '/Users/cltbld', 08:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:19 INFO - 'LOGNAME': 'cltbld', 08:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:19 INFO - 'MOZ_NO_REMOTE': '1', 08:53:19 INFO - 'NO_EM_RESTART': '1', 08:53:19 INFO - 'PAGER': '/bin/cat', 08:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:19 INFO - 'PWD': '/builds/slave/test', 08:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:19 INFO - 'SHELL': '/bin/bash', 08:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:19 INFO - 'USER': 'cltbld', 08:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:19 INFO - 'XPC_FLAGS': '0x0', 08:53:19 INFO - 'XPC_SERVICE_NAME': '0', 08:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:19 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 08:53:19 INFO - Cleaning up... 08:53:19 INFO - Return code: 0 08:53:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', '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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:53: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 psutil>=0.7.1 08:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:19 INFO - 'HOME': '/Users/cltbld', 08:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:19 INFO - 'LOGNAME': 'cltbld', 08:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:19 INFO - 'MOZ_NO_REMOTE': '1', 08:53:19 INFO - 'NO_EM_RESTART': '1', 08:53:19 INFO - 'PAGER': '/bin/cat', 08:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:19 INFO - 'PWD': '/builds/slave/test', 08:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:19 INFO - 'SHELL': '/bin/bash', 08:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:19 INFO - 'USER': 'cltbld', 08:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:19 INFO - 'XPC_FLAGS': '0x0', 08:53:19 INFO - 'XPC_SERVICE_NAME': '0', 08:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:19 INFO - Downloading/unpacking psutil>=0.7.1 08:53:19 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 08:53:19 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 08:53:19 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 08:53:19 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 08:53:19 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 08:53:19 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 08:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:22 INFO - Installing collected packages: psutil 08:53:22 INFO - Running setup.py install for psutil 08:53:22 INFO - building 'psutil._psutil_osx' extension 08:53:22 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 08:53:23 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 08:53:23 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 08:53:23 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 08:53:23 INFO - building 'psutil._psutil_posix' extension 08:53:23 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 08:53:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:23 INFO - ^ 08:53:23 INFO - 1 warning generated. 08:53:23 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 08:53:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:23 INFO - Successfully installed psutil 08:53:23 INFO - Cleaning up... 08:53:23 INFO - Return code: 0 08:53:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:53:23 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')]} 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 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')]} 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:23 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 08:53:23 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 08:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:23 INFO - 'HOME': '/Users/cltbld', 08:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:23 INFO - 'LOGNAME': 'cltbld', 08:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:23 INFO - 'MOZ_NO_REMOTE': '1', 08:53:23 INFO - 'NO_EM_RESTART': '1', 08:53:23 INFO - 'PAGER': '/bin/cat', 08:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:23 INFO - 'PWD': '/builds/slave/test', 08:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:23 INFO - 'SHELL': '/bin/bash', 08:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:23 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:23 INFO - 'USER': 'cltbld', 08:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:23 INFO - 'XPC_FLAGS': '0x0', 08:53:23 INFO - 'XPC_SERVICE_NAME': '0', 08:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:53:26 INFO - Installing collected packages: mozsystemmonitor 08:53:26 INFO - Running setup.py install for mozsystemmonitor 08:53:26 INFO - Successfully installed mozsystemmonitor 08:53:26 INFO - Cleaning up... 08:53:26 INFO - Return code: 0 08:53:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:26 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')]} 08:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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')]} 08:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:26 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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:26 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 08:53:26 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 08:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:26 INFO - 'HOME': '/Users/cltbld', 08:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:26 INFO - 'LOGNAME': 'cltbld', 08:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:26 INFO - 'MOZ_NO_REMOTE': '1', 08:53:26 INFO - 'NO_EM_RESTART': '1', 08:53:26 INFO - 'PAGER': '/bin/cat', 08:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:26 INFO - 'PWD': '/builds/slave/test', 08:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:26 INFO - 'SHELL': '/bin/bash', 08:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:26 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:26 INFO - 'USER': 'cltbld', 08:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:26 INFO - 'XPC_FLAGS': '0x0', 08:53:26 INFO - 'XPC_SERVICE_NAME': '0', 08:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:30 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 08:53:30 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 08:53:30 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 08:53:30 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 08:53:30 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 08:53:30 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 08:53:30 INFO - Downloading docopt-0.6.1.tar.gz 08:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:30 INFO - Running setup.py install for blobuploader 08:53:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:30 INFO - Running setup.py install for requests 08:53:31 INFO - Running setup.py install for docopt 08:53:31 INFO - Successfully installed blobuploader requests docopt 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:31 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 08:53:31 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 08:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:31 INFO - 'HOME': '/Users/cltbld', 08:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PAGER': '/bin/cat', 08:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:31 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - 'XPC_FLAGS': '0x0', 08:53:31 INFO - 'XPC_SERVICE_NAME': '0', 08:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-11ZPxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SxFFt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:31 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kSw6zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yx6DcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-O4xWyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-u2AhAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TT3TNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-fa8W_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-fyEcHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-of1Pbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WCJQu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:32 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ytYOk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-OCkbxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-sBs4eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ogynWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KSjE4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-w8x20i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:33 INFO - Running setup.py install for manifestparser 08:53:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:33 INFO - Running setup.py install for mozcrash 08:53:33 INFO - Running setup.py install for mozdebug 08:53:33 INFO - Running setup.py install for mozdevice 08:53:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Running setup.py install for mozfile 08:53:34 INFO - Running setup.py install for mozhttpd 08:53:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Running setup.py install for mozinfo 08:53:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Running setup.py install for mozInstall 08:53:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:34 INFO - Running setup.py install for mozleak 08:53:34 INFO - Running setup.py install for mozlog 08:53:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Running setup.py install for moznetwork 08:53:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Running setup.py install for mozprocess 08:53:35 INFO - Running setup.py install for mozprofile 08:53:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Running setup.py install for mozrunner 08:53:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:35 INFO - Running setup.py install for mozscreenshot 08:53:35 INFO - Running setup.py install for moztest 08:53:35 INFO - Running setup.py install for mozversion 08:53:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:36 INFO - Cleaning up... 08:53:36 INFO - Return code: 0 08:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:36 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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:36 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 08:53:36 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 08:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:36 INFO - 'HOME': '/Users/cltbld', 08:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:36 INFO - 'LOGNAME': 'cltbld', 08:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:36 INFO - 'MOZ_NO_REMOTE': '1', 08:53:36 INFO - 'NO_EM_RESTART': '1', 08:53:36 INFO - 'PAGER': '/bin/cat', 08:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:36 INFO - 'PWD': '/builds/slave/test', 08:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:36 INFO - 'SHELL': '/bin/bash', 08:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:36 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:36 INFO - 'USER': 'cltbld', 08:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:36 INFO - 'XPC_FLAGS': '0x0', 08:53:36 INFO - 'XPC_SERVICE_NAME': '0', 08:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:36 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8RbmaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:36 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)) 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bAHOEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1TIiSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-arNTMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-P7I1B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Mpdw77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mDYzZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-u_DbTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-JRuHiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GjTnDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:37 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)) 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:37 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pi4Nl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yaJ4In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Q8NWMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7jMOLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TvcALo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-hUcx4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:38 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)) 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:38 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-JFSwWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:38 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)) 08:53:38 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)) 08:53:38 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)) 08:53:38 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)) 08:53:38 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)) 08:53:38 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)) 08:53:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:41 INFO - Downloading blessings-1.6.tar.gz 08:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:41 INFO - Installing collected packages: blessings 08:53:41 INFO - Running setup.py install for blessings 08:53:41 INFO - Successfully installed blessings 08:53:41 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:41 INFO - Reading from file tmpfile_stdout 08:53:41 INFO - Current package versions: 08:53:41 INFO - blessings == 1.6 08:53:41 INFO - blobuploader == 1.2.4 08:53:41 INFO - docopt == 0.6.1 08:53:41 INFO - manifestparser == 1.1 08:53:41 INFO - mozInstall == 1.12 08:53:41 INFO - mozcrash == 0.17 08:53:41 INFO - mozdebug == 0.1 08:53:41 INFO - mozdevice == 0.48 08:53:41 INFO - mozfile == 1.2 08:53:41 INFO - mozhttpd == 0.7 08:53:41 INFO - mozinfo == 0.9 08:53:41 INFO - mozleak == 0.1 08:53:41 INFO - mozlog == 3.1 08:53:41 INFO - moznetwork == 0.27 08:53:41 INFO - mozprocess == 0.22 08:53:41 INFO - mozprofile == 0.28 08:53:41 INFO - mozrunner == 6.11 08:53:41 INFO - mozscreenshot == 0.1 08:53:41 INFO - mozsystemmonitor == 0.0 08:53:41 INFO - moztest == 0.7 08:53:41 INFO - mozversion == 1.4 08:53:41 INFO - psutil == 3.1.1 08:53:41 INFO - requests == 1.2.3 08:53:41 INFO - wsgiref == 0.1.2 08:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 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 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:41 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 08:53:41 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 08:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:41 INFO - 'HOME': '/Users/cltbld', 08:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:41 INFO - 'LOGNAME': 'cltbld', 08:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:41 INFO - 'MOZ_NO_REMOTE': '1', 08:53:41 INFO - 'NO_EM_RESTART': '1', 08:53:41 INFO - 'PAGER': '/bin/cat', 08:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:41 INFO - 'PWD': '/builds/slave/test', 08:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:41 INFO - 'SHELL': '/bin/bash', 08:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:41 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:41 INFO - 'USER': 'cltbld', 08:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:41 INFO - 'XPC_FLAGS': '0x0', 08:53:41 INFO - 'XPC_SERVICE_NAME': '0', 08:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 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)) 08:53:41 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:42 INFO - 'HOME': '/Users/cltbld', 08:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:42 INFO - 'LOGNAME': 'cltbld', 08:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:42 INFO - 'MOZ_NO_REMOTE': '1', 08:53:42 INFO - 'NO_EM_RESTART': '1', 08:53:42 INFO - 'PAGER': '/bin/cat', 08:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:42 INFO - 'PWD': '/builds/slave/test', 08:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:42 INFO - 'SHELL': '/bin/bash', 08:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:42 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:42 INFO - 'USER': 'cltbld', 08:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:42 INFO - 'XPC_FLAGS': '0x0', 08:53:42 INFO - 'XPC_SERVICE_NAME': '0', 08:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:42 INFO - Downloading/unpacking jsonschema 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:44 INFO - Downloading/unpacking functools32 (from jsonschema) 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:45 INFO - warning: no files found matching '*.txt' 08:53:45 INFO - no previously-included directories found matching 'build' 08:53:45 INFO - no previously-included directories found matching 'dist' 08:53:45 INFO - no previously-included directories found matching '.git*' 08:53:45 INFO - Installing collected packages: jsonschema, functools32 08:53:45 INFO - Running setup.py install for functools32 08:53:45 INFO - warning: no files found matching '*.txt' 08:53:45 INFO - no previously-included directories found matching 'build' 08:53:45 INFO - no previously-included directories found matching 'dist' 08:53:45 INFO - no previously-included directories found matching '.git*' 08:53:45 INFO - Successfully installed jsonschema functools32 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109caba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cbb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b2560be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, '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.MixsD3RrPS/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.YkiAAKJxqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:45 INFO - 'HOME': '/Users/cltbld', 08:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PAGER': '/bin/cat', 08:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:53:45 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - 'XPC_FLAGS': '0x0', 08:53:45 INFO - 'XPC_SERVICE_NAME': '0', 08:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 INFO - Downloading/unpacking flake8 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:53:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:53:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:49 INFO - no previously-included directories found matching 'docs/_build' 08:53:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:53:49 INFO - Running setup.py install for pep8 08:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:49 INFO - no previously-included directories found matching 'docs/_build' 08:53:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:53:49 INFO - Cleaning up... 08:53:49 INFO - Return code: 0 08:53:49 INFO - Running post-action listener: _resource_record_post_action 08:53:49 INFO - Running post-action listener: _start_resource_monitoring 08:53:49 INFO - Starting resource monitoring. 08:53:49 INFO - ##### 08:53:49 INFO - ##### Running install step. 08:53:49 INFO - ##### 08:53:49 INFO - Running pre-action listener: _resource_record_pre_action 08:53:49 INFO - Running main action method: install 08:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:50 INFO - Reading from file tmpfile_stdout 08:53:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:50 INFO - Reading from file tmpfile_stdout 08:53:50 INFO - Output received: 08:53:50 INFO - Usage: mozinstall [options] installer 08:53:50 INFO - Options: 08:53:50 INFO - -h, --help show this help message and exit 08:53:50 INFO - -d DEST, --destination=DEST 08:53:50 INFO - Directory to install application into. [default: 08:53:50 INFO - "/builds/slave/test"] 08:53:50 INFO - --app=APP Application being installed. [default: firefox] 08:53:50 INFO - mkdir: /builds/slave/test/build/application 08:53:50 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'] 08:53:50 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 08:54:23 INFO - Reading from file tmpfile_stdout 08:54:23 INFO - Output received: 08:54:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - ##### 08:54:23 INFO - ##### Running run-tests step. 08:54:23 INFO - ##### 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: run_tests 08:54:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:23 INFO - 2016-04-23 08:54:23.917 screenresolution[2267:32754] starting screenresolution argv=screenresolution get 08:54:23 INFO - 2016-04-23 08:54:23.920 screenresolution[2267:32754] Display 0: 1600x1200x32@60 08:54:23 INFO - 2016-04-23 08:54:23.926 screenresolution[2268:32756] starting screenresolution argv=screenresolution list 08:54:23 INFO - Available Modes on Display 0 08:54:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:24 INFO - Intel Iris: 08:54:24 INFO - Chipset Model: Intel Iris 08:54:24 INFO - Type: GPU 08:54:24 INFO - Bus: Built-In 08:54:24 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:24 INFO - Vendor: Intel (0x8086) 08:54:24 INFO - Device ID: 0x0a2e 08:54:24 INFO - Revision ID: 0x0009 08:54:24 INFO - Displays: 08:54:24 INFO - Display: 08:54:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:24 INFO - Display Serial Number: 1600x1200 60 08:54:24 INFO - Main Display: Yes 08:54:24 INFO - Mirror: Off 08:54:24 INFO - Online: Yes 08:54:24 INFO - Rotation: Supported 08:54:24 INFO - Return code: 0 08:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:24 INFO - Python 2.7.3 08:54:24 INFO - Return code: 0 08:54:24 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54:24 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 0x109b4ae00>, '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 0x109973db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b45b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:24 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 08:54:24 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 08:54:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:24 INFO - Return code: 0 08:54:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:54:25 INFO - Return code: 0 08:54:25 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/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:54:25 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/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MixsD3RrPS/Render', 08:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:25 INFO - 'HOME': '/Users/cltbld', 08:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:25 INFO - 'LOGNAME': 'cltbld', 08:54:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:25 INFO - 'MOZ_NO_REMOTE': '1', 08:54:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:25 INFO - 'NO_EM_RESTART': '1', 08:54:25 INFO - 'PAGER': '/bin/cat', 08:54:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:25 INFO - 'PWD': '/builds/slave/test', 08:54:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:25 INFO - 'SHELL': '/bin/bash', 08:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YkiAAKJxqU/Listeners', 08:54:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:25 INFO - 'USER': 'cltbld', 08:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:25 INFO - 'XPC_FLAGS': '0x0', 08:54:25 INFO - 'XPC_SERVICE_NAME': '0', 08:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:25 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/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:25 INFO - mozversion application_buildid: 20160423070820 08:54:25 INFO - mozversion application_changeset: 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b 08:54:25 INFO - mozversion application_display_name: Nightly 08:54:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:25 INFO - mozversion application_name: Firefox 08:54:25 INFO - mozversion application_remotingname: firefox 08:54:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:54:25 INFO - mozversion application_vendor: Mozilla 08:54:25 INFO - mozversion application_version: 48.0a1 08:54:25 INFO - mozversion platform_buildid: 20160423070820 08:54:25 INFO - mozversion platform_changeset: 81e5bf11a1e69b4748d11854bdbb0f4195edcb7b 08:54:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:54:25 INFO - mozversion platform_version: 48.0a1 08:54:25 INFO - using testdate: 1461426865 08:54:25 INFO - actual date: 1461426865 08:54:25 INFO - starting webserver on 'localhost:53964' 08:54:25 INFO - SUITE-START | Running 2 tests 08:54:25 INFO - TEST-START | dromaeo_css 08:54:25 INFO - operating with platform_type : mac_ 08:54:25 INFO - Initialising browser for dromaeo_css test... 08:54:25 INFO - TEST-INFO | started process 2286 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpchTidb/profile http://localhost:53964/getInfo.html) 08:54:27 INFO - PROCESS | 2286 | __metrics Screen width/height:1600/1200 08:54:27 INFO - PROCESS | 2286 | colorDepth:24 08:54:27 INFO - PROCESS | 2286 | Browser inner width/height: 1024/689 08:54:27 INFO - PROCESS | 2286 | __metrics 08:54:28 INFO - PROCESS | 2286 | 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" 08:54:28 ERROR - PROCESS | 2286 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:54:28 INFO - TEST-INFO | 2286: exit 0 08:54:28 INFO - Browser initialized. 08:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:28 INFO - TEST-INFO | started process 2288 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpchTidb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:40 INFO - PROCESS | 2288 | RSS: Main: 239063040 08:54:40 INFO - PROCESS | 2288 | 08:55:31 INFO - PROCESS | 2288 | 1461426931878 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] 08:57:41 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53964/tests/dromaeo/cssquery-ext.html) 08:57:43 INFO - PROCESS | 2288 | RSS: Main: 407064576 08:57:43 INFO - PROCESS | 2288 | 09:00:46 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-ext.html (next: http://localhost:53964/tests/dromaeo/cssquery-jquery.html) 09:00:47 INFO - PROCESS | 2288 | RSS: Main: 380682240 09:00:47 INFO - PROCESS | 2288 | 09:03:49 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53964/tests/dromaeo/cssquery-mootools.html) 09:03:50 INFO - PROCESS | 2288 | RSS: Main: 376885248 09:03:50 INFO - PROCESS | 2288 | 09:06:52 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53964/tests/dromaeo/cssquery-prototype.html) 09:06:53 INFO - PROCESS | 2288 | RSS: Main: 376074240 09:06:53 INFO - PROCESS | 2288 | 09:09:56 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53964/tests/dromaeo/cssquery-yui.html) 09:09:56 INFO - PROCESS | 2288 | RSS: Main: 345845760 09:09:56 INFO - PROCESS | 2288 | 09:12:59 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53964/tests/dromaeo/cssquery-yui.html (next: http://localhost:53964/tests/dromaeo/cssquery-dojo.html) 09:13:00 INFO - PROCESS | 2288 | RSS: Main: 410116096 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | __start_tp_report 09:13:00 INFO - PROCESS | 2288 | _x_x_mozilla_page_load 09:13:00 INFO - PROCESS | 2288 | _x_x_mozilla_page_load_details 09:13:00 INFO - PROCESS | 2288 | |i|pagename|runs| 09:13:00 INFO - PROCESS | 2288 | |0;dojo.html;2947.7936544441886;3391.694747472727;3401.71085457736;3406.914827129323;3460.982695086524;5496.80761173359;5592.468715472029;5621.971890140549;5629.577781666371;5632.7746890124345;4521.480029796574;5644.435556444353;5668.57485688573;5678.545716342693;5703.600747947646;5070.340855688755;5096.439391666932;5122.743862806863;5124.436312005695;5298.549623282006;4672.6261899047995;5102.795888164469;5183.196604526304;5217.34783152106;5272.6836389816735;5083.720395378253;5177.37871455424;5188.974055129738;5194.220866869962;5202.973985130069;5040.6471546991725;5095.363079615048;5135.666181698178;5143.614228932845;5203.505666961632;5066.189409694432;5082.059818933472;5109.335786347789;5115.2071428928575;5140.485951404867;5527.53015993641;5543.223948647153;5548.833534993957;5553.888922221573;5556.86107847303;5997.190379298782;6132.448079672807;6134.754609815602;6226.501879849647;6231.252249730016;5043.899122017576;6130.111133885562;6151.108089327067;6202.472789812871;6209.9068513972325;5681.204631351614;5693.3168019837885;5708.543316534668;5737.426257374313;5738.8278351649515;6167.691615419211;6210.378962103844;6264.968675156595;6304.5586808922935;6326.810195694136;5801.361850196559;5842.948269311565;5861.062230043258;5904.970475147683;5912.083627037816;6017.789377371771;6030.095485677183;6031.24609423822;6051.546134039964;6060.212172417646;5954.702264886739;5979.850503737442;6086.69566521681;6109.083637454418;6148.938510614837;6138.938610613926;6144.152420514445;6170.413810687977;6171.629702217791;6178.598391104564;4867.853964381075;4873.829415970495;4875.414950205927;4906.994066216488;4924.60603151747;4263;4284.3145096784365;4372.300431930876;4417.491988421309;4421.292593185075;5546.112621980464;5552.41699621542;5552.41699621542;5564.248826408464;5582.804601838916;6201.1938448002375;6207.875842483216;6219.720112594944;6224.128621992924;6224.62652240867;5408.45915408456;5521.337439507204;5524.917126243109;5541.861453463695;5598.356189038232;5303.96572668326;5304;5310.4424035476495;5315.335583052119;5341.172118321666;6282.811515654537;6283.3402492737605;6297;6298.622082675054;6316.021016742412;6057.666828324308;6125.571219981412;6162.876742465215;6202.968985155226;6234.064890266496;5462.289902312674;6152.323244443197;6277.089821975879;6291.905621415774;6310.810675679737;6018.428249316308;6055.788047418319;6058.363871793398;6069.51443884497;6070.9089363658695;5970.373110823301;6086.573939824169;6104.969475152596;6132.78535251264;6143.201383820075;5906.497947674324;5931.822045338647;5939.940600593939;5951.196588460502;5958.195643588234;4997.825076122318;5896.528277737685;5907.497862681548;5980.282366116094;6064.302605200459;5738;5779.595428319977;5808.419158084327;5812.7674893003805;5823.126531020381;5798.739056742541;5931.347551769388;5946.226990491382;5969.701514924323;5991.7603295867675;5751.626144300607;5851.385604511465;5880.529557635465;5937.960856850121;5939.376365481562 09:13:00 INFO - PROCESS | 2288 | |1;ext.html;507.8146476536063;528.3131928492959;545.1060261171676;567.6225310168737;599.5563283170452;25614;30992.84503577482;31383;31413.371732565334;31437.05688829333;32902.17744556387;39970.60029399712;40983.180336393256;41011.9747006325;41256.58743412565;7866.92133078669;9770.316077874517;9774.951125244364;9776.755581110458;9830.655927042555;8660.566971651424;9539.90460095397;9676.516174191298;9694.612215511372;9706.417614943126;8807.559622018905;8877.556122193897;8883;8893.777655558599;11504.367259800707;11543.595974140906;11637.010854077414;11639.825402618882;11643.59247426336;11695.181337306349;11404.942975285154;11560.884391156065;11569.305841649528;11570.884291157065;11572;32278.83860580682;39319.213615727815;40459;41413;41428.37857432141;2968.970310296891;3204.1509000114756;3289.1777055736065;3302.0589132097475;3396.5584474018465;22117.557648846934;27575.31061723453;27678.3080422989;27896.860515697495;28081.01716439915;2680.1691475642615;2693.5555633320673;2705.2290097322366;2728.386113124551;2781.415902660444;404690;406048;406261;407564;407932;35556;36489.71592556682;36511.269774604356;59716.222702183724;61061.69469152626;29624.703752962625;35273.294534109176;35528.467072993924;35628.46557301642;35684.821575891954;14848.92575537137;15064.849351506344;15101.244937753068;15111.773323400157;15124.319405626773;12813.679658008625;12876.484940602271;12884.420201090974;12887.806682899763;12895.032872534597;8250.711225107092;8320.334373250125;8351.791205219919;8398.664053437917;8407.70573029941;3192.824394658316;3299.950500742491;3315.336932613487;3437.9656203438144;3463.5670541182353;923.9122283383068;994.0854413939194;1013.9847902281472;1104.690686607751;1146.644540192543;28885;29018.854905725337;29251.85374073116;29561.852190738908;30097.94657186988;1069.8181309177457;1072.0726571515738;1126.1666366888608;1132.17351333527;1189.149757923089;14333.856661433461;14417.567472975827;14863.844742512492;15110.924445377923;15136.697266054618;562720;653365;657350;660052;661684;51752.74123629358;60069.098963515586;60958.695206523684;61017.694911525155;61187.38812611906;1478.460361967874;1522.1095659039586;1527.8854085943376;1531.326216464752;1533.4632878492662;28628.14115576536;28879.5668064975;28912.566311504925;29688.109356719335;30602;53978;54785.72607136939;55345.72327138339;55382;55568.72215638896;592581;597107.0289297051;706109;878969;900900;26550.734492654825;27139.59290610603;27147.321316967234;27151.91392344284;27159.456810864067;45603.315950261436;46464.53535464737;46661.766691166325;46886;46954.29568556543;36907.07732306714;37283.813580933005;37369.813150934075;38407.42388864113;38541.61458385493;37067.62932370749;37200.25599488049;37391;37465.2506949854;38220;37285.067873303386;37541.81229093837;38615.648452304034;38773.03067423337;38824.22351552897;26051.609225861248;32210.516842247853;33113.66886331202;33243.833780830944;33282.16794580155;21062.57874842464;23195.884020580463;24076.398090047187;24449;24789.87605061963 09:13:00 INFO - PROCESS | 2288 | |2;jquery.html;395.90102474381416;396.7222943939243;397.4495323976293;401.27569736625395;410.3823745263378;18985.430437086874;19018.904905475487;19943.700844487325;19960.001999900018;20038.79767213968;19411;19926.40220793375;20393.388198354074;20402.795972040276;20449.59100817983;5631.409492010495;5919.970400147993;5930.288365396159;5939.168516407706;5950.077737950624;5688.857778555528;5814.534837213013;5860.384659610743;5902.409759024106;5905.852353691149;5689.345725241609;5811.796587119452;5831.4751672349485;5851.151583020481;5859.326177489579;5740.942590574083;5770.740316685738;5836;5845.7953971611005;5848.181254624356;5090.33825602673;5102.591792656579;5103.87240318995;5137.049645815536;5139.460356662534;11412.942935285271;12941.935290323489;13451.66370840727;13730;24755.25734227976;2138.807507324348;2192.6272533669153;2230.78807513286;2402.087206861399;2473.826832121752;8981.506017169053;9925.553350099262;9980.001999799963;10098.545565449573;10331.121854642364;1674.715298399275;1738.9913050434666;1775.9289628414977;1809.3938530592136;1862.283021036897;124648;128034.71965280321;130642.693573064;131882;133425.33287333598;9253.907460925438;11507.331436941597;11636.76726465466;11647.63247152337;11813;14902.1803800792;14968.278647955407;15030.549083527512;15034.774478382833;15054.322555485029;8537.402381833212;8769.561521923879;8777.022608833398;8862;8899.15458031486;7574.848503029909;7607.961960190164;7715.074191096992;7741.92258077412;7961.601919903982;4509.549045095464;4585.541445855388;4590.517995610413;4635.745034023161;4663.3937588114;1808.3761102419644;1914.339552854263;1969.5666953270259;1972.7829938706732;2004.8797072175716;393.42167014488655;405.74438103994294;413.5099906610676;759.654357267442;927.846905260638;9352.812943741223;11466;11750.353730544732;11865.762684746256;11912.880871191177;447.2910436957394;455.45345585297775;461.60302140159433;461.66298602020714;478.5788506114597;6052.727627256784;6118.908216376758;6211.223597050369;6241.313455519889;6244.906326405107;600952;610514;611425;618770;618837;131352;137420;137805.6219437793;139242.21515569632;143675;465.96971196872096;467.6422536759314;470.0223535047094;471.4743061486486;472.4779119073443;9214.401063930824;11385.316880987168;11544.056265652205;11644.184907056764;11691.415429228675;35772.74795382149;42407.575924241595;50450.49549504458;50825.49174508356;53127.20309195288;48176.5182348172;68022.65988670025;68370;69510.60978780295;72434.63782681053;8106.432549721463;8217.506949583045;8444.831103378021;8450.56375323517;8654.48073115615;11876.821847672465;12209.511619535118;12351.69120771988;12542.435590398636;12811.679708007374;10802.08182304513;10869.945650272015;10947.397893115955;11030.944845275722;11138.832917506406;10520.631777887736;10734.83897741519;10812.189085818438;10915.945420272848;10916.727081823017;11101.16741244426;11161.665150045512;11163.944180279046;11481.02411295016;11493.080553555528;8047.235512626291;8240.711575094843;8256.669733210605;8271.62777674994;8560.101189375026;8968.237699795329;10925.289856159325;10977.121830253402;11016.339019658846;11131.332120072822 09:13:00 INFO - PROCESS | 2288 | |3;mootools.html;1403.0459287684382;1586.508182463436;1598.137006016751;1852.6665200263956;1989.0651393844887;7860.449768516199;8578.613962371692;8842.425242359242;8856.734297971072;8863.157999989999;8571.914280857189;8627.568621568913;8720.738377848658;8735.388522803407;8747.562621868898;1767.2489192093374;2345.097137602027;2405.6992875890555;2448.2899959011866;2452.766987136228;2438.5976313908186;2459.2007597530874;2466.506698660266;2467.0501856785086;2476.3437689012426;2390.6348704990546;2419.177479656916;2428.0090325932742;2431.3678443604704;2433.963490547634;2092.905819238138;2328;2396.0535588442553;2398.124684490166;2414.420539070628;2255.0754190781863;2284.314705588317;2285.6685780561725;2286.8627882327114;2290.0954123121273;8610.741677749615;8687.3050155988;8698.173673501007;8698.652053917836;8724.912750872538;5044.596432285409;5230.320058392384;5231.163013917755;5240.187770895517;5243.973780131113;2813.776007436751;3292.061762397729;3513.771604845677;3523.260115375774;3529.205928666055;1007.9748006299828;1027.157730660851;1033.302520798458;1034.57065317893;1582.8100627924723;11213.775724485464;11346.773064538664;11375.089992800638;11406.600768973129;11422.657320280405;4243.893902652397;4661.533846615379;4702.57676809082;4824.614030877521;5012.949870501321;9048.909510904938;9059.184673379428;9148.634054637872;9152.22206112488;9157.542122893961;5220.955808838172;5222.060029194706;5237.292965449692;5241.109011468059;5251.8161864335325;4418.823247070145;4428.490723566831;4849.733264670406;4870.82952096682;4873.415190177201;3361.83190840457;3696.519452471215;3769.6041915599017;3784.243151369682;3907.1208977980295;1177.570186881782;1185.3302883870585;1191.434068817305;1191.606769765975;1216.087934049463;906.6237511432813;913.36064754672;922.1516205091332;939.6703664315054;952.1906379577442;5689;5894.8821023579285;5957.314908785458;5977.820665379959;5990.820275391745;452.5045075642167;466.7619514047792;469.97650117493987;480.02075765438116;483.6711036495217;3119.8284094375026;3955.723099383016;4018.3771515415156;4055.0065234017857;4094.733842300241;10384.636537721295;10405;10935.83596246057;10937;10939.56241750321;10726.98093681099;10872.402017889091;10887.564497420015;10922.29005114665;10926.672199834018;8106.108328083906;8239.505629662119;8250.834983300301;8276.917230827736;8361.996560412668;5777.45114214149;5875.941240587539;5889.94110058894;5920.8815823684145;5965.224520812267;9377.531123443938;9659.855102173613;9808.264380171373;10175.796484070424;10182.981701829758;9533.618655253713;9849.901500985185;9952.303338766216;9960.800783984134;10060.597576097167;6772.661366931535;7019.578825270296;7157.1769246537315;7203.855922881408;7519.548827070394;8112.675492980215;8121.918780812116;8193.754187374388;8193.959030204811;8224.465409748347;7199.3520583147765;7215.60314182725;7239.167495738057;7353.411727061715;7454.366378857858;5978.730957106854;7036.331548502884;7079.292070793085;7200.135983681992;7235.421166306788;6723.5293529452465;6930.44556435494;6954.8956765647545;6957.582545047313;6968.338007889242;4827.493113223061;4864.975675121602;4915.410150781786;4978.352814134139;5083.212102124176;3925.5681874994298;4562.771861406983;4759.428868535798;4815.951840481691;4892.143874821821 09:13:00 INFO - PROCESS | 2288 | |4;prototype.html;310.91605266578017;315.04855336882616;320.071791803769;322.94671379222444;328.06665037966974;5935.910961335583;6032.547558933081;6033.276006879175;6034.577579569432;6044.065898912349;5398.433164517728;5800.013997620405;5847.181394604759;5951.494122999539;5980.342162362137;4258.084511829956;4310.741355518663;4415.8233670653135;4462.263726485126;4509.819607215707;4403.163398954189;4455.131249406367;4462.419885414892;4477.283634618461;4480.955190448102;4449.065696203801;4453.576910193543;4470.776461176944;4473.686841921067;4484.170428470743;4200.894977625538;4213.47331583552;4457.33140028995;4497.820087196508;4501;3268.0032590060023;3852.248811481762;3884.1454879926373;3889.747166434173;3893.279743247508;4674;5748.9651862664705;5757.712114394305;5771.105478650816;5808.270113046861;3963.920721585552;4535.523770004135;5174.482551744795;5181.715005674687;5186.118359878792;5252;6266.248050233956;6279.434850863398;6297.771934472779;6323.14637523933;3643.198496330803;4216.987922898482;4256.680748943811;4284.64344610463;4297.646241433969;5753.510951569122;6329.968350158219;6408.198975128109;6598;6676.165479315086;3906.4921560196995;4099.815508302134;4310.181065597589;4365.497967733688;4393.692441529126;4220.303649897733;4331.052626412344;4465.218586747306;4466.397036400044;4484.977575112103;5036.294918711384;5149.897002060013;5159.638825282269;5170.689758614495;5181.948180518222;5463.535599474089;5487.780488780484;6193.721282542297;6339.651319177489;6405.135306733531;1496.1098146602753;1516.5829396915715;1518.9696206075816;1537.1161582090342;1538.8076490438696;951.8191543606831;983.588550430135;1007.3955626624113;1025.1132770153913;1029.624187171677;5855;5980.162777211194;5991.940080599225;6031.9396806032255;6047.123167140828;6324.462420694201;6653.900191497131;6655.835228834934;6656.302642826048;6707.865842683119;5763.308402991668;5808.186853840381;5874.1776151338845;5996.310424301261;6038.396160384014;3003.57949887016;3179.9188275986276;3423.863045478203;3502.8073455960166;3514.24443744591;6154.138420621117;6304.810855674337;6634.635095069721;6931.376176144171;6984.161900571862;6400.967995160087;6788.796336109925;6804.149481314836;6853.538962823742;6860.759873404407;6012.302171467094;6266.436020757971;6314.084457753692;6381.617102973836;6915.273896240822;5792.102224155263;6066.848328791815;6331.620102793847;6573.408393244631;6598.802035938929;6482.319356467503;6510.762955038527;6531.150950376421;6552.312007239171;6553.377429144223;5284.867878303073;6168.563417449992;6484.221893372825;6900.689468974008;6947.40947019509;4085.3054980653956;4252.255855225385;4314.180305742025;4314.5038320592275;4333.696641235083;5516.393196748274;6066.787662431793;6252.1559589456665;6637.535372523877;6666;5416.485433883775;6380.457661098859;6383.7127329271225;6406.679666016587;6430.3891130342545;5317.989581979412;6128.253447767365;6285.968570157303;6385.785381648276;6386.105945167587;4642.582167604932;4647.512011238771;4764.475907650087;6092.116643086639;6233.75064997395;6377.744890204525;6398.904016439664;6412.487001039999;6415.422611964946;6428.164338635947;5937.376575459514;6121.755129794937;6253.96873015632;6285.59143655661;6286.874262514815 09:13:00 INFO - PROCESS | 2288 | |5;yui.html;649.886269902767;719.2124623537225;734.159387501311;736.7053178728511;763.2443880558249;14573.854261457382;15030.323635436403;15084.547463576111;15094.698106037873;15117.94174407792;13739.58781236562;13813.93093034536;13839.723205535884;13841.377138028787;13844;914.2777206007246;943.8584212368131;951.1392190068;952.2572393533055;953.3088510829663;925.4678559828092;938.7606160429115;943.3679434778714;943.5942544705774;945.4516380499329;991.8313886639289;992.7319623701596;992.9205663546899;992.9722736967241;993.8558908958197;985.5417230987589;986.8963758805294;989.1443901025597;989.2975987049203;989.8515222716578;733.5342057793287;736.5139008254527;736.6684991753679;738.6380673470014;739.5340935210783;15317.31072101747;15388.461403850812;15413.922930385277;15428.228588570639;15429.691406171814;12139.575114871026;12155.878441215564;12237.938810305892;12286.754264914742;12595.6071518859;9801;10032.749181270454;10223.948880255626;10353.63762268317;10365.222608304408;3403.506491558735;3484.181217413906;3536.29274145172;3555.377808883435;3643.617420170897;59083.87717118601;77810;78233.60883195547;78382.21617783807;83626;9290.535473226311;9333.90666093344;9382.343235973553;9627.326087173971;9650.469224192737;20300.289489867784;20565.69151462729;20587.4853128673;20605.587888242153;20635;7459.328660420588;7460.253974602496;7469.320659326444;7535.773926782205;7611.809704757426;3428.7428442866885;3973.543042550086;4093.3450647896193;4128;4206.969292523351;3519.296140771856;3603.6216197298904;3606.2607165531003;3609.620989796086;3617.3127105849803;627.6181741566089;640.5644161969905;644.754993102618;644.8001119652922;646.331047365974;491.38576779026215;559.9804006859822;560.6944215402615;577.8382053025159;604.7611193578512;6841.836887729098;7840.764777056697;7884.487508311941;8005.839883202303;8259.504429734236;560.1961185698535;560.8138786466594;568.4287291272245;590.103043374069;596.1475090620368;3748.8517589811395;3755.117547376364;3764.7176461765475;3827.3684842001317;3834.1373191031794;87703.24593508094;87755;89339;89767;89853.55073224723;62157.13528594149;66318;72003;72596;72650;65487;67198.66400667965;67407.32592674109;67752.66123669449;67843.66078169577;7339.669714862951;7382.5939573323985;7541.849163016818;7554.4334174936;7570.507916985378;42462;42726.359104612835;43190.56809431865;44237.77881110574;45064.774676126406;44899;56747.73009079591;61920.45198869884;62676;62741.68629156825;9849.852252216366;9872.802543949225;11002.669919902415;11175.49710263024;11244.156688248579;11585.246958947642;11841;11883.287002779862;11954.760904781682;12007.879921200676;11154.498047587716;11294.887051129712;11552.364619945984;11579.536818527165;11611.477483513094;11300.604478843201;11476;11579.942100289445;11654.18420710576;11681.941590291994;11360.431978401211;11394.145439091935;11495.195336326711;11735.47190376418;11770.411479426166;9400;9453.716388508356;9454.196393306645;9558.713238602853;9888.802223955625;9452.669156579486;9691.70924872255;9713.902860971582;9721.465319407218;9756 09:13:00 INFO - PROCESS | 2288 | __end_tp_report 09:13:00 INFO - PROCESS | 2288 | __start_cc_report 09:13:00 INFO - PROCESS | 2288 | _x_x_mozilla_cycle_collect,1613 09:13:00 INFO - PROCESS | 2288 | __end_cc_report 09:13:00 INFO - PROCESS | 2288 | __startTimestamp1461427980041__endTimestamp 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | ------- Summary: start ------- 09:13:00 INFO - PROCESS | 2288 | Number of tests: 6 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#0] dojo.html Cycles:165 Average:5622.87 Median:5801.36 stddev:633.65 (10.9%) stddev-sans-first:599.84 09:13:00 INFO - PROCESS | 2288 | Values: 2947.8 3391.7 3401.7 3406.9 3461.0 5496.8 5592.5 5622.0 5629.6 5632.8 4521.5 5644.4 5668.6 5678.5 5703.6 5070.3 5096.4 5122.7 5124.4 5298.5 4672.6 5102.8 5183.2 5217.3 5272.7 5083.7 5177.4 5189.0 5194.2 5203.0 5040.6 5095.4 5135.7 5143.6 5203.5 5066.2 5082.1 5109.3 5115.2 5140.5 5527.5 5543.2 5548.8 5553.9 5556.9 5997.2 6132.4 6134.8 6226.5 6231.3 5043.9 6130.1 6151.1 6202.5 6209.9 5681.2 5693.3 5708.5 5737.4 5738.8 6167.7 6210.4 6265.0 6304.6 6326.8 5801.4 5842.9 5861.1 5905.0 5912.1 6017.8 6030.1 6031.2 6051.5 6060.2 5954.7 5979.9 6086.7 6109.1 6148.9 6138.9 6144.2 6170.4 6171.6 6178.6 4867.9 4873.8 4875.4 4907.0 4924.6 4263.0 4284.3 4372.3 4417.5 4421.3 5546.1 5552.4 5552.4 5564.2 5582.8 6201.2 6207.9 6219.7 6224.1 6224.6 5408.5 5521.3 5524.9 5541.9 5598.4 5304.0 5304.0 5310.4 5315.3 5341.2 6282.8 6283.3 6297.0 6298.6 6316.0 6057.7 6125.6 6162.9 6203.0 6234.1 5462.3 6152.3 6277.1 6291.9 6310.8 6018.4 6055.8 6058.4 6069.5 6070.9 5970.4 6086.6 6105.0 6132.8 6143.2 5906.5 5931.8 5939.9 5951.2 5958.2 4997.8 5896.5 5907.5 5980.3 6064.3 5738.0 5779.6 5808.4 5812.8 5823.1 5798.7 5931.3 5946.2 5969.7 5991.8 5751.6 5851.4 5880.5 5938.0 5939.4 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#1] ext.html Cycles:180 Average:70184.19 Median:3450.77 stddev:165638.80 (4800.1%) stddev-sans-first:166020.85 09:13:00 INFO - PROCESS | 2288 | Values: 507.8 528.3 545.1 567.6 599.6 25614.0 30992.8 31383.0 31413.4 31437.1 32902.2 39970.6 40983.2 41012.0 41256.6 7866.9 9770.3 9775.0 9776.8 9830.7 8660.6 9539.9 9676.5 9694.6 9706.4 8807.6 8877.6 8883.0 8893.8 11504.4 11543.6 11637.0 11639.8 11643.6 11695.2 11404.9 11560.9 11569.3 11570.9 11572.0 32278.8 39319.2 40459.0 41413.0 41428.4 2969.0 3204.2 3289.2 3302.1 3396.6 22117.6 27575.3 27678.3 27896.9 28081.0 2680.2 2693.6 2705.2 2728.4 2781.4 404690.0 406048.0 406261.0 407564.0 407932.0 35556.0 36489.7 36511.3 59716.2 61061.7 29624.7 35273.3 35528.5 35628.5 35684.8 14848.9 15064.8 15101.2 15111.8 15124.3 12813.7 12876.5 12884.4 12887.8 12895.0 8250.7 8320.3 8351.8 8398.7 8407.7 3192.8 3300.0 3315.3 3438.0 3463.6 923.9 994.1 1014.0 1104.7 1146.6 28885.0 29018.9 29251.9 29561.9 30097.9 1069.8 1072.1 1126.2 1132.2 1189.1 14333.9 14417.6 14863.8 15110.9 15136.7 562720.0 653365.0 657350.0 660052.0 661684.0 51752.7 60069.1 60958.7 61017.7 61187.4 1478.5 1522.1 1527.9 1531.3 1533.5 28628.1 28879.6 28912.6 29688.1 30602.0 53978.0 54785.7 55345.7 55382.0 55568.7 592581.0 597107.0 706109.0 878969.0 900900.0 26550.7 27139.6 27147.3 27151.9 27159.5 45603.3 46464.5 46661.8 46886.0 46954.3 36907.1 37283.8 37369.8 38407.4 38541.6 37067.6 37200.3 37391.0 37465.3 38220.0 37285.1 37541.8 38615.6 38773.0 38824.2 26051.6 32210.5 33113.7 33243.8 33282.2 21062.6 23195.9 24076.4 24449.0 24789.9 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#2] jquery.html Cycles:180 Average:34476.19 Median:411.95 stddev:102649.28 (24918.1%) stddev-sans-first:102905.34 09:13:00 INFO - PROCESS | 2288 | Values: 395.9 396.7 397.4 401.3 410.4 18985.4 19018.9 19943.7 19960.0 20038.8 19411.0 19926.4 20393.4 20402.8 20449.6 5631.4 5920.0 5930.3 5939.2 5950.1 5688.9 5814.5 5860.4 5902.4 5905.9 5689.3 5811.8 5831.5 5851.2 5859.3 5740.9 5770.7 5836.0 5845.8 5848.2 5090.3 5102.6 5103.9 5137.0 5139.5 11412.9 12941.9 13451.7 13730.0 24755.3 2138.8 2192.6 2230.8 2402.1 2473.8 8981.5 9925.6 9980.0 10098.5 10331.1 1674.7 1739.0 1775.9 1809.4 1862.3 124648.0 128034.7 130642.7 131882.0 133425.3 9253.9 11507.3 11636.8 11647.6 11813.0 14902.2 14968.3 15030.5 15034.8 15054.3 8537.4 8769.6 8777.0 8862.0 8899.2 7574.8 7608.0 7715.1 7741.9 7961.6 4509.5 4585.5 4590.5 4635.7 4663.4 1808.4 1914.3 1969.6 1972.8 2004.9 393.4 405.7 413.5 759.7 927.8 9352.8 11466.0 11750.4 11865.8 11912.9 447.3 455.5 461.6 461.7 478.6 6052.7 6118.9 6211.2 6241.3 6244.9 600952.0 610514.0 611425.0 618770.0 618837.0 131352.0 137420.0 137805.6 139242.2 143675.0 466.0 467.6 470.0 471.5 472.5 9214.4 11385.3 11544.1 11644.2 11691.4 35772.7 42407.6 50450.5 50825.5 53127.2 48176.5 68022.7 68370.0 69510.6 72434.6 8106.4 8217.5 8444.8 8450.6 8654.5 11876.8 12209.5 12351.7 12542.4 12811.7 10802.1 10869.9 10947.4 11030.9 11138.8 10520.6 10734.8 10812.2 10915.9 10916.7 11101.2 11161.7 11163.9 11481.0 11493.1 8047.2 8240.7 8256.7 8271.6 8560.1 8968.2 10925.3 10977.1 11016.3 11131.3 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#3] mootools.html Cycles:180 Average:5599.51 Median:4867.90 stddev:3162.85 (65.0%) stddev-sans-first:3156.00 09:13:00 INFO - PROCESS | 2288 | Values: 1403.0 1586.5 1598.1 1852.7 1989.1 7860.4 8578.6 8842.4 8856.7 8863.2 8571.9 8627.6 8720.7 8735.4 8747.6 1767.2 2345.1 2405.7 2448.3 2452.8 2438.6 2459.2 2466.5 2467.1 2476.3 2390.6 2419.2 2428.0 2431.4 2434.0 2092.9 2328.0 2396.1 2398.1 2414.4 2255.1 2284.3 2285.7 2286.9 2290.1 8610.7 8687.3 8698.2 8698.7 8724.9 5044.6 5230.3 5231.2 5240.2 5244.0 2813.8 3292.1 3513.8 3523.3 3529.2 1008.0 1027.2 1033.3 1034.6 1582.8 11213.8 11346.8 11375.1 11406.6 11422.7 4243.9 4661.5 4702.6 4824.6 5012.9 9048.9 9059.2 9148.6 9152.2 9157.5 5221.0 5222.1 5237.3 5241.1 5251.8 4418.8 4428.5 4849.7 4870.8 4873.4 3361.8 3696.5 3769.6 3784.2 3907.1 1177.6 1185.3 1191.4 1191.6 1216.1 906.6 913.4 922.2 939.7 952.2 5689.0 5894.9 5957.3 5977.8 5990.8 452.5 466.8 470.0 480.0 483.7 3119.8 3955.7 4018.4 4055.0 4094.7 10384.6 10405.0 10935.8 10937.0 10939.6 10727.0 10872.4 10887.6 10922.3 10926.7 8106.1 8239.5 8250.8 8276.9 8362.0 5777.5 5875.9 5889.9 5920.9 5965.2 9377.5 9659.9 9808.3 10175.8 10183.0 9533.6 9849.9 9952.3 9960.8 10060.6 6772.7 7019.6 7157.2 7203.9 7519.5 8112.7 8121.9 8193.8 8194.0 8224.5 7199.4 7215.6 7239.2 7353.4 7454.4 5978.7 7036.3 7079.3 7200.1 7235.4 6723.5 6930.4 6954.9 6957.6 6968.3 4827.5 4865.0 4915.4 4978.4 5083.2 3925.6 4562.8 4759.4 4816.0 4892.1 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#4] prototype.html Cycles:180 Average:5113.65 Median:5796.06 stddev:1600.17 (27.6%) stddev-sans-first:1563.53 09:13:00 INFO - PROCESS | 2288 | Values: 310.9 315.0 320.1 322.9 328.1 5935.9 6032.5 6033.3 6034.6 6044.1 5398.4 5800.0 5847.2 5951.5 5980.3 4258.1 4310.7 4415.8 4462.3 4509.8 4403.2 4455.1 4462.4 4477.3 4481.0 4449.1 4453.6 4470.8 4473.7 4484.2 4200.9 4213.5 4457.3 4497.8 4501.0 3268.0 3852.2 3884.1 3889.7 3893.3 4674.0 5749.0 5757.7 5771.1 5808.3 3963.9 4535.5 5174.5 5181.7 5186.1 5252.0 6266.2 6279.4 6297.8 6323.1 3643.2 4217.0 4256.7 4284.6 4297.6 5753.5 6330.0 6408.2 6598.0 6676.2 3906.5 4099.8 4310.2 4365.5 4393.7 4220.3 4331.1 4465.2 4466.4 4485.0 5036.3 5149.9 5159.6 5170.7 5181.9 5463.5 5487.8 6193.7 6339.7 6405.1 1496.1 1516.6 1519.0 1537.1 1538.8 951.8 983.6 1007.4 1025.1 1029.6 5855.0 5980.2 5991.9 6031.9 6047.1 6324.5 6653.9 6655.8 6656.3 6707.9 5763.3 5808.2 5874.2 5996.3 6038.4 3003.6 3179.9 3423.9 3502.8 3514.2 6154.1 6304.8 6634.6 6931.4 6984.2 6401.0 6788.8 6804.1 6853.5 6860.8 6012.3 6266.4 6314.1 6381.6 6915.3 5792.1 6066.8 6331.6 6573.4 6598.8 6482.3 6510.8 6531.2 6552.3 6553.4 5284.9 6168.6 6484.2 6900.7 6947.4 4085.3 4252.3 4314.2 4314.5 4333.7 5516.4 6066.8 6252.2 6637.5 6666.0 5416.5 6380.5 6383.7 6406.7 6430.4 5318.0 6128.3 6286.0 6385.8 6386.1 4642.6 4647.5 4764.5 6092.1 6233.8 6377.7 6398.9 6412.5 6415.4 6428.2 5937.4 6121.8 6254.0 6285.6 6286.9 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - PROCESS | 2288 | [#5] yui.html Cycles:180 Average:17208.27 Median:62038.79 stddev:23683.09 (38.2%) stddev-sans-first:23716.89 09:13:00 INFO - PROCESS | 2288 | Values: 649.9 719.2 734.2 736.7 763.2 14573.9 15030.3 15084.5 15094.7 15117.9 13739.6 13813.9 13839.7 13841.4 13844.0 914.3 943.9 951.1 952.3 953.3 925.5 938.8 943.4 943.6 945.5 991.8 992.7 992.9 993.0 993.9 985.5 986.9 989.1 989.3 989.9 733.5 736.5 736.7 738.6 739.5 15317.3 15388.5 15413.9 15428.2 15429.7 12139.6 12155.9 12237.9 12286.8 12595.6 9801.0 10032.7 10223.9 10353.6 10365.2 3403.5 3484.2 3536.3 3555.4 3643.6 59083.9 77810.0 78233.6 78382.2 83626.0 9290.5 9333.9 9382.3 9627.3 9650.5 20300.3 20565.7 20587.5 20605.6 20635.0 7459.3 7460.3 7469.3 7535.8 7611.8 3428.7 3973.5 4093.3 4128.0 4207.0 3519.3 3603.6 3606.3 3609.6 3617.3 627.6 640.6 644.8 644.8 646.3 491.4 560.0 560.7 577.8 604.8 6841.8 7840.8 7884.5 8005.8 8259.5 560.2 560.8 568.4 590.1 596.1 3748.9 3755.1 3764.7 3827.4 3834.1 87703.2 87755.0 89339.0 89767.0 89853.6 62157.1 66318.0 72003.0 72596.0 72650.0 65487.0 67198.7 67407.3 67752.7 67843.7 7339.7 7382.6 7541.8 7554.4 7570.5 42462.0 42726.4 43190.6 44237.8 45064.8 44899.0 56747.7 61920.5 62676.0 62741.7 9849.9 9872.8 11002.7 11175.5 11244.2 11585.2 11841.0 11883.3 11954.8 12007.9 11154.5 11294.9 11552.4 11579.5 11611.5 11300.6 11476.0 11579.9 11654.2 11681.9 11360.4 11394.1 11495.2 11735.5 11770.4 9400.0 9453.7 9454.2 9558.7 9888.8 9452.7 9691.7 9713.9 9721.5 9756.0 09:13:00 INFO - PROCESS | 2288 | -------- Summary: end -------- 09:13:00 INFO - PROCESS | 2288 | 09:13:00 INFO - TEST-INFO | 2288: exit 0 09:13:00 INFO - TEST-OK | dromaeo_css | took 1115139ms 09:13:00 INFO - TEST-START | kraken 09:13:00 INFO - operating with platform_type : mac_ 09:13:00 INFO - Initialising browser for kraken test... 09:13:00 INFO - TEST-INFO | started process 2291 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpdRrgMO/profile http://localhost:53964/getInfo.html) 09:13:03 INFO - PROCESS | 2291 | __metrics Screen width/height:1600/1200 09:13:03 INFO - PROCESS | 2291 | colorDepth:24 09:13:03 INFO - PROCESS | 2291 | Browser inner width/height: 1024/689 09:13:03 INFO - PROCESS | 2291 | __metrics 09:13:03 INFO - PROCESS | 2291 | 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" 09:13:03 ERROR - PROCESS | 2291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:13:03 INFO - TEST-INFO | 2291: exit 0 09:13:03 INFO - Browser initialized. 09:13:03 INFO - Running cycle 1/1 for kraken test... 09:13:03 INFO - TEST-INFO | started process 2293 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpdRrgMO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:15 INFO - PROCESS | 2293 | RSS: Main: 239198208 09:13:15 INFO - PROCESS | 2293 | 09:13:18 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53964/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:19 INFO - PROCESS | 2293 | RSS: Main: 287309824 09:13:19 INFO - PROCESS | 2293 | 09:13:21 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53964/tests/kraken/driver.html?testName=audio-dft) 09:13:22 INFO - PROCESS | 2293 | RSS: Main: 300044288 09:13:22 INFO - PROCESS | 2293 | 09:13:26 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53964/tests/kraken/driver.html?testName=audio-fft) 09:13:26 INFO - PROCESS | 2293 | RSS: Main: 388726784 09:13:26 INFO - PROCESS | 2293 | 09:13:28 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53964/tests/kraken/driver.html?testName=audio-oscillator) 09:13:29 INFO - PROCESS | 2293 | RSS: Main: 287178752 09:13:29 INFO - PROCESS | 2293 | 09:13:31 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:32 INFO - PROCESS | 2293 | RSS: Main: 291389440 09:13:32 INFO - PROCESS | 2293 | 09:13:34 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53964/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:35 INFO - PROCESS | 2293 | RSS: Main: 329371648 09:13:35 INFO - PROCESS | 2293 | 09:13:38 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53964/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:39 INFO - PROCESS | 2293 | RSS: Main: 331436032 09:13:39 INFO - PROCESS | 2293 | 09:13:41 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53964/tests/kraken/driver.html?testName=json-parse-financial) 09:13:42 INFO - PROCESS | 2293 | RSS: Main: 329785344 09:13:42 INFO - PROCESS | 2293 | 09:13:44 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:44 INFO - PROCESS | 2293 | RSS: Main: 321916928 09:13:44 INFO - PROCESS | 2293 | 09:13:46 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:47 INFO - PROCESS | 2293 | RSS: Main: 329695232 09:13:47 INFO - PROCESS | 2293 | 09:13:49 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:50 INFO - PROCESS | 2293 | RSS: Main: 330317824 09:13:50 INFO - PROCESS | 2293 | 09:13:52 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:53 INFO - PROCESS | 2293 | RSS: Main: 335724544 09:13:53 INFO - PROCESS | 2293 | 09:13:56 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:57 INFO - PROCESS | 2293 | RSS: Main: 333086720 09:13:57 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:53964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53964/tests/kraken/driver.html?testName=ai-astar) 09:13:59 INFO - PROCESS | 2293 | RSS: Main: 398434304 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | __start_tp_report 09:13:59 INFO - PROCESS | 2293 | _x_x_mozilla_page_load 09:13:59 INFO - PROCESS | 2293 | _x_x_mozilla_page_load_details 09:13:59 INFO - PROCESS | 2293 | |i|pagename|runs| 09:13:59 INFO - PROCESS | 2293 | |0;ai-astar;113;114;108;114;113;113;113;113;106;114 09:13:59 INFO - PROCESS | 2293 | |1;audio-beat-detection;158;122;146;172;121;144;140;121;175;120 09:13:59 INFO - PROCESS | 2293 | |2;audio-dft;184;186;189;188;187;186;181;185;184;188 09:13:59 INFO - PROCESS | 2293 | |3;audio-fft;77;95;128;123;57;58;57;82;86;57 09:13:59 INFO - PROCESS | 2293 | |4;audio-oscillator;93;105;138;78;79;81;158;120;120;128 09:13:59 INFO - PROCESS | 2293 | |5;imaging-gaussian-blur;90;87;89;88;89;86;90;85;91;71 09:13:59 INFO - PROCESS | 2293 | |6;imaging-darkroom;93;95;96;94;94;94;95;108;151;101 09:13:59 INFO - PROCESS | 2293 | |7;imaging-desaturate;86;85;87;85;84;85;87;85;86;84 09:13:59 INFO - PROCESS | 2293 | |8;json-parse-financial;60;63;61;61;59;61;58;78;60;59 09:13:59 INFO - PROCESS | 2293 | |9;json-stringify-tinderbox;64;63;69;78;75;72;67;67;66;67 09:13:59 INFO - PROCESS | 2293 | |10;stanford-crypto-aes;82;81;82;82;83;82;82;81;83;84 09:13:59 INFO - PROCESS | 2293 | |11;stanford-crypto-ccm;140;163;157;137;141;155;149;136;169;163 09:13:59 INFO - PROCESS | 2293 | |12;stanford-crypto-pbkdf2;172;174;174;172;181;173;209;171;172;175 09:13:59 INFO - PROCESS | 2293 | |13;stanford-crypto-sha256-iterative;70;69;70;69;82;87;101;99;69;67 09:13:59 INFO - PROCESS | 2293 | __end_tp_report 09:13:59 INFO - PROCESS | 2293 | __start_cc_report 09:13:59 INFO - PROCESS | 2293 | _x_x_mozilla_cycle_collect,2075 09:13:59 INFO - PROCESS | 2293 | __end_cc_report 09:13:59 INFO - PROCESS | 2293 | __startTimestamp1461428039288__endTimestamp 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | ------- Summary: start ------- 09:13:59 INFO - PROCESS | 2293 | Number of tests: 14 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.77 (2.4%) stddev-sans-first:2.92 09:13:59 INFO - PROCESS | 2293 | Values: 113.0 114.0 108.0 114.0 113.0 113.0 113.0 113.0 106.0 114.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:145.00 stddev:21.17 (14.6%) stddev-sans-first:21.64 09:13:59 INFO - PROCESS | 2293 | Values: 158.0 122.0 146.0 172.0 121.0 144.0 140.0 121.0 175.0 120.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.50 stddev:2.39 (1.3%) stddev-sans-first:2.45 09:13:59 INFO - PROCESS | 2293 | Values: 184.0 186.0 189.0 188.0 187.0 186.0 181.0 185.0 184.0 188.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#3] audio-fft Cycles:10 Average:82.00 Median:67.50 stddev:26.79 (39.7%) stddev-sans-first:28.35 09:13:59 INFO - PROCESS | 2293 | Values: 77.0 95.0 128.0 123.0 57.0 58.0 57.0 82.0 86.0 57.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:118.00 stddev:27.39 (23.2%) stddev-sans-first:28.35 09:13:59 INFO - PROCESS | 2293 | Values: 93.0 105.0 138.0 78.0 79.0 81.0 158.0 120.0 120.0 128.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:89.00 stddev:5.80 (6.5%) stddev-sans-first:6.02 09:13:59 INFO - PROCESS | 2293 | Values: 90.0 87.0 89.0 88.0 89.0 86.0 90.0 85.0 91.0 71.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:94.00 stddev:17.78 (18.9%) stddev-sans-first:18.55 09:13:59 INFO - PROCESS | 2293 | Values: 93.0 95.0 96.0 94.0 94.0 94.0 95.0 108.0 151.0 101.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:1.12 09:13:59 INFO - PROCESS | 2293 | Values: 86.0 85.0 87.0 85.0 84.0 85.0 87.0 85.0 86.0 84.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:61.00 stddev:5.79 (9.5%) stddev-sans-first:6.10 09:13:59 INFO - PROCESS | 2293 | Values: 60.0 63.0 61.0 61.0 59.0 61.0 58.0 78.0 60.0 59.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:4.80 (7.1%) stddev-sans-first:4.77 09:13:59 INFO - PROCESS | 2293 | Values: 64.0 63.0 69.0 78.0 75.0 72.0 67.0 67.0 66.0 67.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 09:13:59 INFO - PROCESS | 2293 | Values: 82.0 81.0 82.0 82.0 83.0 82.0 82.0 81.0 83.0 84.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:156.00 stddev:12.06 (7.7%) stddev-sans-first:12.12 09:13:59 INFO - PROCESS | 2293 | Values: 140.0 163.0 157.0 137.0 141.0 155.0 149.0 136.0 169.0 163.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:174.00 stddev:11.49 (6.6%) stddev-sans-first:12.03 09:13:59 INFO - PROCESS | 2293 | Values: 172.0 174.0 174.0 172.0 181.0 173.0 209.0 171.0 172.0 175.0 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - PROCESS | 2293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.30 Median:70.00 stddev:13.16 (18.8%) stddev-sans-first:13.61 09:13:59 INFO - PROCESS | 2293 | Values: 70.0 69.0 70.0 69.0 82.0 87.0 101.0 99.0 69.0 67.0 09:13:59 INFO - PROCESS | 2293 | -------- Summary: end -------- 09:13:59 INFO - PROCESS | 2293 | 09:13:59 INFO - TEST-INFO | 2293: exit 0 09:14:00 INFO - TEST-OK | kraken | took 59334ms 09:14:00 INFO - SUITE-END | took 1174s 09:14:00 INFO - Completed test suite (00:19:34) 09:14:00 INFO - javascript benchmark 09:14:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2947.7936544441886, 3391.694747472727, 3401.71085457736, 3406.914827129323, 3460.982695086524, 5496.80761173359, 5592.468715472029, 5621.971890140549, 5629.577781666371, 5632.7746890124345, 4521.480029796574, 5644.435556444353, 5668.57485688573, 5678.545716342693, 5703.600747947646, 5070.340855688755, 5096.439391666932, 5122.743862806863, 5124.436312005695, 5298.549623282006, 4672.6261899047995, 5102.795888164469, 5183.196604526304, 5217.34783152106, 5272.6836389816735, 5083.720395378253, 5177.37871455424, 5188.974055129738, 5194.220866869962, 5202.973985130069, 5040.6471546991725, 5095.363079615048, 5135.666181698178, 5143.614228932845, 5203.505666961632, 5066.189409694432, 5082.059818933472, 5109.335786347789, 5115.2071428928575, 5140.485951404867, 5527.53015993641, 5543.223948647153, 5548.833534993957, 5553.888922221573, 5556.86107847303, 5997.190379298782, 6132.448079672807, 6134.754609815602, 6226.501879849647, 6231.252249730016, 5043.899122017576, 6130.111133885562, 6151.108089327067, 6202.472789812871, 6209.9068513972325, 5681.204631351614, 5693.3168019837885, 5708.543316534668, 5737.426257374313, 5738.8278351649515, 6167.691615419211, 6210.378962103844, 6264.968675156595, 6304.5586808922935, 6326.810195694136, 5801.361850196559, 5842.948269311565, 5861.062230043258, 5904.970475147683, 5912.083627037816, 6017.789377371771, 6030.095485677183, 6031.24609423822, 6051.546134039964, 6060.212172417646, 5954.702264886739, 5979.850503737442, 6086.69566521681, 6109.083637454418, 6148.938510614837, 6138.938610613926, 6144.152420514445, 6170.413810687977, 6171.629702217791, 6178.598391104564, 4867.853964381075, 4873.829415970495, 4875.414950205927, 4906.994066216488, 4924.60603151747, 4263.0, 4284.3145096784365, 4372.300431930876, 4417.491988421309, 4421.292593185075, 5546.112621980464, 5552.41699621542, 5552.41699621542, 5564.248826408464, 5582.804601838916, 6201.1938448002375, 6207.875842483216, 6219.720112594944, 6224.128621992924, 6224.62652240867, 5408.45915408456, 5521.337439507204, 5524.917126243109, 5541.861453463695, 5598.356189038232, 5303.96572668326, 5304.0, 5310.4424035476495, 5315.335583052119, 5341.172118321666, 6282.811515654537, 6283.3402492737605, 6297.0, 6298.622082675054, 6316.021016742412, 6057.666828324308, 6125.571219981412, 6162.876742465215, 6202.968985155226, 6234.064890266496, 5462.289902312674, 6152.323244443197, 6277.089821975879, 6291.905621415774, 6310.810675679737, 6018.428249316308, 6055.788047418319, 6058.363871793398, 6069.51443884497, 6070.9089363658695, 5970.373110823301, 6086.573939824169, 6104.969475152596, 6132.78535251264, 6143.201383820075, 5906.497947674324, 5931.822045338647, 5939.940600593939, 5951.196588460502, 5958.195643588234, 4997.825076122318, 5896.528277737685, 5907.497862681548, 5980.282366116094, 6064.302605200459, 5738.0, 5779.595428319977, 5808.419158084327, 5812.7674893003805, 5823.126531020381, 5798.739056742541, 5931.347551769388, 5946.226990491382, 5969.701514924323, 5991.7603295867675, 5751.626144300607, 5851.385604511465, 5880.529557635465, 5937.960856850121, 5939.376365481562], "value": 5583.4256230850515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.8146476536063, 528.3131928492959, 545.1060261171676, 567.6225310168737, 599.5563283170452, 25614.0, 30992.84503577482, 31383.0, 31413.371732565334, 31437.05688829333, 32902.17744556387, 39970.60029399712, 40983.180336393256, 41011.9747006325, 41256.58743412565, 7866.92133078669, 9770.316077874517, 9774.951125244364, 9776.755581110458, 9830.655927042555, 8660.566971651424, 9539.90460095397, 9676.516174191298, 9694.612215511372, 9706.417614943126, 8807.559622018905, 8877.556122193897, 8883.0, 8893.777655558599, 11504.367259800707, 11543.595974140906, 11637.010854077414, 11639.825402618882, 11643.59247426336, 11695.181337306349, 11404.942975285154, 11560.884391156065, 11569.305841649528, 11570.884291157065, 11572.0, 32278.83860580682, 39319.213615727815, 40459.0, 41413.0, 41428.37857432141, 2968.970310296891, 3204.1509000114756, 3289.1777055736065, 3302.0589132097475, 3396.5584474018465, 22117.557648846934, 27575.31061723453, 27678.3080422989, 27896.860515697495, 28081.01716439915, 2680.1691475642615, 2693.5555633320673, 2705.2290097322366, 2728.386113124551, 2781.415902660444, 404690.0, 406048.0, 406261.0, 407564.0, 407932.0, 35556.0, 36489.71592556682, 36511.269774604356, 59716.222702183724, 61061.69469152626, 29624.703752962625, 35273.294534109176, 35528.467072993924, 35628.46557301642, 35684.821575891954, 14848.92575537137, 15064.849351506344, 15101.244937753068, 15111.773323400157, 15124.319405626773, 12813.679658008625, 12876.484940602271, 12884.420201090974, 12887.806682899763, 12895.032872534597, 8250.711225107092, 8320.334373250125, 8351.791205219919, 8398.664053437917, 8407.70573029941, 3192.824394658316, 3299.950500742491, 3315.336932613487, 3437.9656203438144, 3463.5670541182353, 923.9122283383068, 994.0854413939194, 1013.9847902281472, 1104.690686607751, 1146.644540192543, 28885.0, 29018.854905725337, 29251.85374073116, 29561.852190738908, 30097.94657186988, 1069.8181309177457, 1072.0726571515738, 1126.1666366888608, 1132.17351333527, 1189.149757923089, 14333.856661433461, 14417.567472975827, 14863.844742512492, 15110.924445377923, 15136.697266054618, 562720.0, 653365.0, 657350.0, 660052.0, 661684.0, 51752.74123629358, 60069.098963515586, 60958.695206523684, 61017.694911525155, 61187.38812611906, 1478.460361967874, 1522.1095659039586, 1527.8854085943376, 1531.326216464752, 1533.4632878492662, 28628.14115576536, 28879.5668064975, 28912.566311504925, 29688.109356719335, 30602.0, 53978.0, 54785.72607136939, 55345.72327138339, 55382.0, 55568.72215638896, 592581.0, 597107.0289297051, 706109.0, 878969.0, 900900.0, 26550.734492654825, 27139.59290610603, 27147.321316967234, 27151.91392344284, 27159.456810864067, 45603.315950261436, 46464.53535464737, 46661.766691166325, 46886.0, 46954.29568556543, 36907.07732306714, 37283.813580933005, 37369.813150934075, 38407.42388864113, 38541.61458385493, 37067.62932370749, 37200.25599488049, 37391.0, 37465.2506949854, 38220.0, 37285.067873303386, 37541.81229093837, 38615.648452304034, 38773.03067423337, 38824.22351552897, 26051.609225861248, 32210.516842247853, 33113.66886331202, 33243.833780830944, 33282.16794580155, 21062.57874842464, 23195.884020580463, 24076.398090047187, 24449.0, 24789.87605061963], "value": 18478.743212411104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.90102474381416, 396.7222943939243, 397.4495323976293, 401.27569736625395, 410.3823745263378, 18985.430437086874, 19018.904905475487, 19943.700844487325, 19960.001999900018, 20038.79767213968, 19411.0, 19926.40220793375, 20393.388198354074, 20402.795972040276, 20449.59100817983, 5631.409492010495, 5919.970400147993, 5930.288365396159, 5939.168516407706, 5950.077737950624, 5688.857778555528, 5814.534837213013, 5860.384659610743, 5902.409759024106, 5905.852353691149, 5689.345725241609, 5811.796587119452, 5831.4751672349485, 5851.151583020481, 5859.326177489579, 5740.942590574083, 5770.740316685738, 5836.0, 5845.7953971611005, 5848.181254624356, 5090.33825602673, 5102.591792656579, 5103.87240318995, 5137.049645815536, 5139.460356662534, 11412.942935285271, 12941.935290323489, 13451.66370840727, 13730.0, 24755.25734227976, 2138.807507324348, 2192.6272533669153, 2230.78807513286, 2402.087206861399, 2473.826832121752, 8981.506017169053, 9925.553350099262, 9980.001999799963, 10098.545565449573, 10331.121854642364, 1674.715298399275, 1738.9913050434666, 1775.9289628414977, 1809.3938530592136, 1862.283021036897, 124648.0, 128034.71965280321, 130642.693573064, 131882.0, 133425.33287333598, 9253.907460925438, 11507.331436941597, 11636.76726465466, 11647.63247152337, 11813.0, 14902.1803800792, 14968.278647955407, 15030.549083527512, 15034.774478382833, 15054.322555485029, 8537.402381833212, 8769.561521923879, 8777.022608833398, 8862.0, 8899.15458031486, 7574.848503029909, 7607.961960190164, 7715.074191096992, 7741.92258077412, 7961.601919903982, 4509.549045095464, 4585.541445855388, 4590.517995610413, 4635.745034023161, 4663.3937588114, 1808.3761102419644, 1914.339552854263, 1969.5666953270259, 1972.7829938706732, 2004.8797072175716, 393.42167014488655, 405.74438103994294, 413.5099906610676, 759.654357267442, 927.846905260638, 9352.812943741223, 11466.0, 11750.353730544732, 11865.762684746256, 11912.880871191177, 447.2910436957394, 455.45345585297775, 461.60302140159433, 461.66298602020714, 478.5788506114597, 6052.727627256784, 6118.908216376758, 6211.223597050369, 6241.313455519889, 6244.906326405107, 600952.0, 610514.0, 611425.0, 618770.0, 618837.0, 131352.0, 137420.0, 137805.6219437793, 139242.21515569632, 143675.0, 465.96971196872096, 467.6422536759314, 470.0223535047094, 471.4743061486486, 472.4779119073443, 9214.401063930824, 11385.316880987168, 11544.056265652205, 11644.184907056764, 11691.415429228675, 35772.74795382149, 42407.575924241595, 50450.49549504458, 50825.49174508356, 53127.20309195288, 48176.5182348172, 68022.65988670025, 68370.0, 69510.60978780295, 72434.63782681053, 8106.432549721463, 8217.506949583045, 8444.831103378021, 8450.56375323517, 8654.48073115615, 11876.821847672465, 12209.511619535118, 12351.69120771988, 12542.435590398636, 12811.679708007374, 10802.08182304513, 10869.945650272015, 10947.397893115955, 11030.944845275722, 11138.832917506406, 10520.631777887736, 10734.83897741519, 10812.189085818438, 10915.945420272848, 10916.727081823017, 11101.16741244426, 11161.665150045512, 11163.944180279046, 11481.02411295016, 11493.080553555528, 8047.235512626291, 8240.711575094843, 8256.669733210605, 8271.62777674994, 8560.101189375026, 8968.237699795329, 10925.289856159325, 10977.121830253402, 11016.339019658846, 11131.332120072822], "value": 8443.00193245597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.0459287684382, 1586.508182463436, 1598.137006016751, 1852.6665200263956, 1989.0651393844887, 7860.449768516199, 8578.613962371692, 8842.425242359242, 8856.734297971072, 8863.157999989999, 8571.914280857189, 8627.568621568913, 8720.738377848658, 8735.388522803407, 8747.562621868898, 1767.2489192093374, 2345.097137602027, 2405.6992875890555, 2448.2899959011866, 2452.766987136228, 2438.5976313908186, 2459.2007597530874, 2466.506698660266, 2467.0501856785086, 2476.3437689012426, 2390.6348704990546, 2419.177479656916, 2428.0090325932742, 2431.3678443604704, 2433.963490547634, 2092.905819238138, 2328.0, 2396.0535588442553, 2398.124684490166, 2414.420539070628, 2255.0754190781863, 2284.314705588317, 2285.6685780561725, 2286.8627882327114, 2290.0954123121273, 8610.741677749615, 8687.3050155988, 8698.173673501007, 8698.652053917836, 8724.912750872538, 5044.596432285409, 5230.320058392384, 5231.163013917755, 5240.187770895517, 5243.973780131113, 2813.776007436751, 3292.061762397729, 3513.771604845677, 3523.260115375774, 3529.205928666055, 1007.9748006299828, 1027.157730660851, 1033.302520798458, 1034.57065317893, 1582.8100627924723, 11213.775724485464, 11346.773064538664, 11375.089992800638, 11406.600768973129, 11422.657320280405, 4243.893902652397, 4661.533846615379, 4702.57676809082, 4824.614030877521, 5012.949870501321, 9048.909510904938, 9059.184673379428, 9148.634054637872, 9152.22206112488, 9157.542122893961, 5220.955808838172, 5222.060029194706, 5237.292965449692, 5241.109011468059, 5251.8161864335325, 4418.823247070145, 4428.490723566831, 4849.733264670406, 4870.82952096682, 4873.415190177201, 3361.83190840457, 3696.519452471215, 3769.6041915599017, 3784.243151369682, 3907.1208977980295, 1177.570186881782, 1185.3302883870585, 1191.434068817305, 1191.606769765975, 1216.087934049463, 906.6237511432813, 913.36064754672, 922.1516205091332, 939.6703664315054, 952.1906379577442, 5689.0, 5894.8821023579285, 5957.314908785458, 5977.820665379959, 5990.820275391745, 452.5045075642167, 466.7619514047792, 469.97650117493987, 480.02075765438116, 483.6711036495217, 3119.8284094375026, 3955.723099383016, 4018.3771515415156, 4055.0065234017857, 4094.733842300241, 10384.636537721295, 10405.0, 10935.83596246057, 10937.0, 10939.56241750321, 10726.98093681099, 10872.402017889091, 10887.564497420015, 10922.29005114665, 10926.672199834018, 8106.108328083906, 8239.505629662119, 8250.834983300301, 8276.917230827736, 8361.996560412668, 5777.45114214149, 5875.941240587539, 5889.94110058894, 5920.8815823684145, 5965.224520812267, 9377.531123443938, 9659.855102173613, 9808.264380171373, 10175.796484070424, 10182.981701829758, 9533.618655253713, 9849.901500985185, 9952.303338766216, 9960.800783984134, 10060.597576097167, 6772.661366931535, 7019.578825270296, 7157.1769246537315, 7203.855922881408, 7519.548827070394, 8112.675492980215, 8121.918780812116, 8193.754187374388, 8193.959030204811, 8224.465409748347, 7199.3520583147765, 7215.60314182725, 7239.167495738057, 7353.411727061715, 7454.366378857858, 5978.730957106854, 7036.331548502884, 7079.292070793085, 7200.135983681992, 7235.421166306788, 6723.5293529452465, 6930.44556435494, 6954.8956765647545, 6957.582545047313, 6968.338007889242, 4827.493113223061, 4864.975675121602, 4915.410150781786, 4978.352814134139, 5083.212102124176, 3925.5681874994298, 4562.771861406983, 4759.428868535798, 4815.951840481691, 4892.143874821821], "value": 4441.761270417848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.91605266578017, 315.04855336882616, 320.071791803769, 322.94671379222444, 328.06665037966974, 5935.910961335583, 6032.547558933081, 6033.276006879175, 6034.577579569432, 6044.065898912349, 5398.433164517728, 5800.013997620405, 5847.181394604759, 5951.494122999539, 5980.342162362137, 4258.084511829956, 4310.741355518663, 4415.8233670653135, 4462.263726485126, 4509.819607215707, 4403.163398954189, 4455.131249406367, 4462.419885414892, 4477.283634618461, 4480.955190448102, 4449.065696203801, 4453.576910193543, 4470.776461176944, 4473.686841921067, 4484.170428470743, 4200.894977625538, 4213.47331583552, 4457.33140028995, 4497.820087196508, 4501.0, 3268.0032590060023, 3852.248811481762, 3884.1454879926373, 3889.747166434173, 3893.279743247508, 4674.0, 5748.9651862664705, 5757.712114394305, 5771.105478650816, 5808.270113046861, 3963.920721585552, 4535.523770004135, 5174.482551744795, 5181.715005674687, 5186.118359878792, 5252.0, 6266.248050233956, 6279.434850863398, 6297.771934472779, 6323.14637523933, 3643.198496330803, 4216.987922898482, 4256.680748943811, 4284.64344610463, 4297.646241433969, 5753.510951569122, 6329.968350158219, 6408.198975128109, 6598.0, 6676.165479315086, 3906.4921560196995, 4099.815508302134, 4310.181065597589, 4365.497967733688, 4393.692441529126, 4220.303649897733, 4331.052626412344, 4465.218586747306, 4466.397036400044, 4484.977575112103, 5036.294918711384, 5149.897002060013, 5159.638825282269, 5170.689758614495, 5181.948180518222, 5463.535599474089, 5487.780488780484, 6193.721282542297, 6339.651319177489, 6405.135306733531, 1496.1098146602753, 1516.5829396915715, 1518.9696206075816, 1537.1161582090342, 1538.8076490438696, 951.8191543606831, 983.588550430135, 1007.3955626624113, 1025.1132770153913, 1029.624187171677, 5855.0, 5980.162777211194, 5991.940080599225, 6031.9396806032255, 6047.123167140828, 6324.462420694201, 6653.900191497131, 6655.835228834934, 6656.302642826048, 6707.865842683119, 5763.308402991668, 5808.186853840381, 5874.1776151338845, 5996.310424301261, 6038.396160384014, 3003.57949887016, 3179.9188275986276, 3423.863045478203, 3502.8073455960166, 3514.24443744591, 6154.138420621117, 6304.810855674337, 6634.635095069721, 6931.376176144171, 6984.161900571862, 6400.967995160087, 6788.796336109925, 6804.149481314836, 6853.538962823742, 6860.759873404407, 6012.302171467094, 6266.436020757971, 6314.084457753692, 6381.617102973836, 6915.273896240822, 5792.102224155263, 6066.848328791815, 6331.620102793847, 6573.408393244631, 6598.802035938929, 6482.319356467503, 6510.762955038527, 6531.150950376421, 6552.312007239171, 6553.377429144223, 5284.867878303073, 6168.563417449992, 6484.221893372825, 6900.689468974008, 6947.40947019509, 4085.3054980653956, 4252.255855225385, 4314.180305742025, 4314.5038320592275, 4333.696641235083, 5516.393196748274, 6066.787662431793, 6252.1559589456665, 6637.535372523877, 6666.0, 5416.485433883775, 6380.457661098859, 6383.7127329271225, 6406.679666016587, 6430.3891130342545, 5317.989581979412, 6128.253447767365, 6285.968570157303, 6385.785381648276, 6386.105945167587, 4642.582167604932, 4647.512011238771, 4764.475907650087, 6092.116643086639, 6233.75064997395, 6377.744890204525, 6398.904016439664, 6412.487001039999, 6415.422611964946, 6428.164338635947, 5937.376575459514, 6121.755129794937, 6253.96873015632, 6285.59143655661, 6286.874262514815], "value": 4597.78980504661, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.886269902767, 719.2124623537225, 734.159387501311, 736.7053178728511, 763.2443880558249, 14573.854261457382, 15030.323635436403, 15084.547463576111, 15094.698106037873, 15117.94174407792, 13739.58781236562, 13813.93093034536, 13839.723205535884, 13841.377138028787, 13844.0, 914.2777206007246, 943.8584212368131, 951.1392190068, 952.2572393533055, 953.3088510829663, 925.4678559828092, 938.7606160429115, 943.3679434778714, 943.5942544705774, 945.4516380499329, 991.8313886639289, 992.7319623701596, 992.9205663546899, 992.9722736967241, 993.8558908958197, 985.5417230987589, 986.8963758805294, 989.1443901025597, 989.2975987049203, 989.8515222716578, 733.5342057793287, 736.5139008254527, 736.6684991753679, 738.6380673470014, 739.5340935210783, 15317.31072101747, 15388.461403850812, 15413.922930385277, 15428.228588570639, 15429.691406171814, 12139.575114871026, 12155.878441215564, 12237.938810305892, 12286.754264914742, 12595.6071518859, 9801.0, 10032.749181270454, 10223.948880255626, 10353.63762268317, 10365.222608304408, 3403.506491558735, 3484.181217413906, 3536.29274145172, 3555.377808883435, 3643.617420170897, 59083.87717118601, 77810.0, 78233.60883195547, 78382.21617783807, 83626.0, 9290.535473226311, 9333.90666093344, 9382.343235973553, 9627.326087173971, 9650.469224192737, 20300.289489867784, 20565.69151462729, 20587.4853128673, 20605.587888242153, 20635.0, 7459.328660420588, 7460.253974602496, 7469.320659326444, 7535.773926782205, 7611.809704757426, 3428.7428442866885, 3973.543042550086, 4093.3450647896193, 4128.0, 4206.969292523351, 3519.296140771856, 3603.6216197298904, 3606.2607165531003, 3609.620989796086, 3617.3127105849803, 627.6181741566089, 640.5644161969905, 644.754993102618, 644.8001119652922, 646.331047365974, 491.38576779026215, 559.9804006859822, 560.6944215402615, 577.8382053025159, 604.7611193578512, 6841.836887729098, 7840.764777056697, 7884.487508311941, 8005.839883202303, 8259.504429734236, 560.1961185698535, 560.8138786466594, 568.4287291272245, 590.103043374069, 596.1475090620368, 3748.8517589811395, 3755.117547376364, 3764.7176461765475, 3827.3684842001317, 3834.1373191031794, 87703.24593508094, 87755.0, 89339.0, 89767.0, 89853.55073224723, 62157.13528594149, 66318.0, 72003.0, 72596.0, 72650.0, 65487.0, 67198.66400667965, 67407.32592674109, 67752.66123669449, 67843.66078169577, 7339.669714862951, 7382.5939573323985, 7541.849163016818, 7554.4334174936, 7570.507916985378, 42462.0, 42726.359104612835, 43190.56809431865, 44237.77881110574, 45064.774676126406, 44899.0, 56747.73009079591, 61920.45198869884, 62676.0, 62741.68629156825, 9849.852252216366, 9872.802543949225, 11002.669919902415, 11175.49710263024, 11244.156688248579, 11585.246958947642, 11841.0, 11883.287002779862, 11954.760904781682, 12007.879921200676, 11154.498047587716, 11294.887051129712, 11552.364619945984, 11579.536818527165, 11611.477483513094, 11300.604478843201, 11476.0, 11579.942100289445, 11654.18420710576, 11681.941590291994, 11360.431978401211, 11394.145439091935, 11495.195336326711, 11735.47190376418, 11770.411479426166, 9400.0, 9453.716388508356, 9454.196393306645, 9558.713238602853, 9888.802223955625, 9452.669156579486, 9691.70924872255, 9713.902860971582, 9721.465319407218, 9756.0], "value": 6782.8564623875545, "unit": "score"}], "name": "dromaeo_css", "value": 7029.712284010097, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 108.0, 114.0, 113.0, 113.0, 113.0, 113.0, 106.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 146.0, 172.0, 121.0, 144.0, 140.0, 121.0, 175.0, 120.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 189.0, 188.0, 187.0, 186.0, 181.0, 185.0, 184.0, 188.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 95.0, 128.0, 123.0, 57.0, 58.0, 57.0, 82.0, 86.0, 57.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 105.0, 138.0, 78.0, 79.0, 81.0, 158.0, 120.0, 120.0, 128.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 88.0, 89.0, 86.0, 90.0, 85.0, 91.0, 71.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 108.0, 151.0, 101.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 85.0, 84.0, 85.0, 87.0, 85.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 61.0, 59.0, 61.0, 58.0, 78.0, 60.0, 59.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 69.0, 78.0, 75.0, 72.0, 67.0, 67.0, 66.0, 67.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0, 81.0, 83.0, 84.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 163.0, 157.0, 137.0, 141.0, 155.0, 149.0, 136.0, 169.0, 163.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 174.0, 172.0, 181.0, 173.0, 209.0, 171.0, 172.0, 175.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 82.0, 87.0, 101.0, 99.0, 69.0, 67.0], "value": 78.3, "unit": "score"}], "name": "kraken", "value": 1525.5, "alertThreshold": 2.0}]} 09:14:00 INFO - Return code: 0 09:14:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:14:00 ERROR - # TBPL SUCCESS # 09:14:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:00 INFO - 2016-04-23 09:14:00.591 screenresolution[2297:34800] starting screenresolution argv=screenresolution get 09:14:00 INFO - 2016-04-23 09:14:00.593 screenresolution[2297:34800] Display 0: 1600x1200x32@60 09:14:00 INFO - 2016-04-23 09:14:00.599 screenresolution[2298:34803] starting screenresolution argv=screenresolution list 09:14:00 INFO - Available Modes on Display 0 09:14:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:00 INFO - Intel Iris: 09:14:00 INFO - Chipset Model: Intel Iris 09:14:00 INFO - Type: GPU 09:14:00 INFO - Bus: Built-In 09:14:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:00 INFO - Vendor: Intel (0x8086) 09:14:00 INFO - Device ID: 0x0a2e 09:14:00 INFO - Revision ID: 0x0009 09:14:00 INFO - Displays: 09:14:00 INFO - Display: 09:14:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:00 INFO - Display Serial Number: 1600x1200 60 09:14:00 INFO - Main Display: Yes 09:14:00 INFO - Mirror: Off 09:14:00 INFO - Online: Yes 09:14:00 INFO - Rotation: Supported 09:14:00 INFO - Return code: 0 09:14:00 INFO - Running post-action listener: _resource_record_post_action 09:14:00 INFO - Running post-run listener: _resource_record_post_run 09:14:01 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 368640; Write bytes: 691081216; Read time: 4; Write time: 1853 09:14:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395766272; Write bytes: 396674560; Read time: 29805; Write time: 684 09:14:01 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 368640; Write bytes: 293558784; Read time: 4; Write time: 1166 09:14:01 INFO - Running post-run listener: _upload_blobber_files 09:14:01 INFO - Blob upload gear active. 09:14:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:01 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 09:14:01 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'] 09:14:01 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 09:14:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:03 INFO - (blobuploader) - INFO - Done attempting. 09:14:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:04 INFO - (blobuploader) - INFO - Done attempting. 09:14:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:04 INFO - Return code: 0 09:14:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d40294e1ee441a6ea70a3afee932b5d9f28b53241c9e5c0e177df0cee0acfb63416ef92d174c8e4770ae81eb900d5b9a5b17df60a5a63aac2acabdf701fee67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94e8418a9b304afd943397ad353a8662f8b15c96db70bdbdcd04a0eda0e5b7019c6992feba45720e1fabdddff0c295d0b2cb2c10d16ae14cb906237e933cc3cf"} 09:14:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:04 INFO - Contents: 09:14:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d40294e1ee441a6ea70a3afee932b5d9f28b53241c9e5c0e177df0cee0acfb63416ef92d174c8e4770ae81eb900d5b9a5b17df60a5a63aac2acabdf701fee67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94e8418a9b304afd943397ad353a8662f8b15c96db70bdbdcd04a0eda0e5b7019c6992feba45720e1fabdddff0c295d0b2cb2c10d16ae14cb906237e933cc3cf"} 09:14:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:04 INFO - Copying logs to upload dir... 09:14:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.309691 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-23 09:14:04.312568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 09:14:04.316665) ========= 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.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d40294e1ee441a6ea70a3afee932b5d9f28b53241c9e5c0e177df0cee0acfb63416ef92d174c8e4770ae81eb900d5b9a5b17df60a5a63aac2acabdf701fee67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94e8418a9b304afd943397ad353a8662f8b15c96db70bdbdcd04a0eda0e5b7019c6992feba45720e1fabdddff0c295d0b2cb2c10d16ae14cb906237e933cc3cf"} build_url:https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010757 build_url: 'https://queue.taskcluster.net/v1/task/DSHxp28_TVC43EdzwYltKA/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/4d40294e1ee441a6ea70a3afee932b5d9f28b53241c9e5c0e177df0cee0acfb63416ef92d174c8e4770ae81eb900d5b9a5b17df60a5a63aac2acabdf701fee67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94e8418a9b304afd943397ad353a8662f8b15c96db70bdbdcd04a0eda0e5b7019c6992feba45720e1fabdddff0c295d0b2cb2c10d16ae14cb906237e933cc3cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 09:14:04.343457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:14:04.343829) ========= 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.MixsD3RrPS/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.YkiAAKJxqU/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005563 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:14:04.394878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 09:14:04.395418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 09:14:04.396751) ========= ========= Total master_lag: 9.16 =========