builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1461253428.36 results: success (0) buildid: 20160421071514 builduid: b27a81864e4b453b9b8ff9e4b031b323 revision: 9073060fceb054ed745bec841a904caaf68bfa02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.363316) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.363853) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.364149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.384714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.385143) ========= 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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-21 08:43:48-- 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% 9.13M=0.001s 2016-04-21 08:43:48 (9.13 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.497003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.497362) ========= 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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.026007 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:48.545784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 08:43:48.546160) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9073060fceb054ed745bec841a904caaf68bfa02 --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 9073060fceb054ed745bec841a904caaf68bfa02 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-21 08:43:48,621 truncating revision to first 12 chars 2016-04-21 08:43:48,621 Setting DEBUG logging. 2016-04-21 08:43:48,621 attempt 1/10 2016-04-21 08:43:48,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9073060fceb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 08:43:49,933 unpacking tar archive at: fx-team-9073060fceb0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 08:43:50.104799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:50.105168) ========= script_repo_revision: 9073060fceb054ed745bec841a904caaf68bfa02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:50.105580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:50.105874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 08:43:50.118964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-21 08:43:50.119380) ========= /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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:43:50 INFO - MultiFileLogger online at 20160421 08:43:50 in /builds/slave/test 08:43:50 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:43:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:50 INFO - {'append_to_log': False, 08:43:50 INFO - 'base_work_dir': '/builds/slave/test', 08:43:50 INFO - 'blob_upload_branch': 'Fx-Team', 08:43:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:50 INFO - 'branch': 'Fx-Team', 08:43:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:50 INFO - 'config_files': ('talos/mac_config.py',), 08:43:50 INFO - 'default_actions': ('clobber', 08:43:50 INFO - 'read-buildbot-config', 08:43:50 INFO - 'download-and-extract', 08:43:50 INFO - 'populate-webroot', 08:43:50 INFO - 'create-virtualenv', 08:43:50 INFO - 'install', 08:43:50 INFO - 'run-tests'), 08:43:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:50 INFO - 'download_minidump_stackwalk': True, 08:43:50 INFO - 'download_symbols': 'ondemand', 08:43:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:50 INFO - 'installer_path': 'installer.exe', 08:43:50 INFO - 'log_level': 'info', 08:43:50 INFO - 'log_name': 'talos', 08:43:50 INFO - 'log_to_console': True, 08:43:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:43:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:43:50 INFO - 'opt_config_files': (), 08:43:50 INFO - 'pip_index': False, 08:43:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:50 INFO - 'cmd': ('bash', 08:43:50 INFO - '-c', 08:43:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:50 INFO - 'enabled': True, 08:43:50 INFO - 'halt_on_failure': False, 08:43:50 INFO - 'name': 'check_screen_resolution'},), 08:43:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:50 INFO - 'cmd': ('bash', 08:43:50 INFO - '-c', 08:43:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:50 INFO - 'enabled': True, 08:43:50 INFO - 'halt_on_failure': False, 08:43:50 INFO - 'name': 'check_screen_resolution'},), 08:43:50 INFO - 'run_cmd_checks_enabled': True, 08:43:50 INFO - 'sps_profile': False, 08:43:50 INFO - 'sps_profile_interval': 0, 08:43:50 INFO - 'suite': 'dromaeojs', 08:43:50 INFO - 'system_bits': '32', 08:43:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:50 INFO - 'title': 't-yosemite-r7-0152', 08:43:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:50 INFO - 'use_talos_json': True, 08:43:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:50 INFO - 'work_dir': 'build'} 08:43:50 INFO - ##### 08:43:50 INFO - ##### Running clobber step. 08:43:50 INFO - ##### 08:43:50 INFO - Running pre-action listener: _resource_record_pre_action 08:43:50 INFO - Running main action method: clobber 08:43:50 INFO - rmtree: /builds/slave/test/build 08:43:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:51 INFO - Running post-action listener: _resource_record_post_action 08:43:51 INFO - ##### 08:43:51 INFO - ##### Running read-buildbot-config step. 08:43:51 INFO - ##### 08:43:51 INFO - Running pre-action listener: _resource_record_pre_action 08:43:51 INFO - Running main action method: read_buildbot_config 08:43:51 INFO - Using buildbot properties: 08:43:51 INFO - { 08:43:51 INFO - "project": "", 08:43:51 INFO - "product": "firefox", 08:43:51 INFO - "script_repo_revision": "production", 08:43:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:43:51 INFO - "repository": "", 08:43:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:43:51 INFO - "buildid": "20160421071514", 08:43:51 INFO - "pgo_build": "False", 08:43:51 INFO - "basedir": "/builds/slave/test", 08:43:51 INFO - "buildnumber": 688, 08:43:51 INFO - "slavename": "t-yosemite-r7-0152", 08:43:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:43:51 INFO - "platform": "yosemite_r7", 08:43:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:43:51 INFO - "branch": "fx-team", 08:43:51 INFO - "repo_path": "integration/fx-team", 08:43:51 INFO - "revision": "9073060fceb054ed745bec841a904caaf68bfa02", 08:43:51 INFO - "stage_platform": "macosx64", 08:43:51 INFO - "builduid": "b27a81864e4b453b9b8ff9e4b031b323", 08:43:51 INFO - "slavebuilddir": "test" 08:43:51 INFO - } 08:43:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:43:51 INFO - Running post-action listener: _resource_record_post_action 08:43:51 INFO - ##### 08:43:51 INFO - ##### Running download-and-extract step. 08:43:51 INFO - ##### 08:43:51 INFO - Running pre-action listener: _resource_record_pre_action 08:43:51 INFO - Running main action method: download_and_extract 08:43:51 INFO - mkdir: /builds/slave/test/build/tests 08:43:51 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:43:51 INFO - https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:43:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:43:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:43:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:53 INFO - Downloaded 1199 bytes. 08:43:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:43:53 INFO - Using the following test package requirements: 08:43:53 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:43:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:43:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:43:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'jsshell-mac.zip'], 08:43:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:43:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:43:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:43:53 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:43:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:43:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:43:53 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:43:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:43:53 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:43:53 INFO - https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:54 INFO - Downloaded 18099880 bytes. 08:43:54 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:43:54 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:43:57 INFO - Return code: 0 08:43:57 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:43:57 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:43:57 INFO - https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:43:58 INFO - Downloaded 18099880 bytes. 08:43:58 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:43:58 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:44:02 INFO - Return code: 0 08:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:02 INFO - https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:44:03 INFO - Downloaded 10845952 bytes. 08:44:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:44:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:44:03 INFO - Return code: 0 08:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:03 INFO - https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UHJwo8C6SmarfTypZMASGw/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:44:06 INFO - Downloaded 109956753 bytes. 08:44:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:44:06 INFO - mkdir: /builds/slave/test/properties 08:44:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:06 INFO - Contents: 08:44:06 INFO - build_url:https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:44:07 INFO - Running post-action listener: _resource_record_post_action 08:44:07 INFO - Running post-action listener: set_extra_try_arguments 08:44:07 INFO - ##### 08:44:07 INFO - ##### Running populate-webroot step. 08:44:07 INFO - ##### 08:44:07 INFO - Running pre-action listener: _resource_record_pre_action 08:44:07 INFO - Running main action method: populate_webroot 08:44:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:07 INFO - '--tppagecycles', 08:44:07 INFO - '7'], 08:44:07 INFO - 'tests': ['tsvgm']}}, 08:44:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['damp', 'tps']}, 08:44:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'tests': ['damp', 'tps']}, 08:44:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['dromaeo_dom']}, 08:44:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['a11yr', 08:44:07 INFO - 'ts_paint', 08:44:07 INFO - 'tpaint', 08:44:07 INFO - 'sessionrestore', 08:44:07 INFO - 'sessionrestore_no_auto_restore', 08:44:07 INFO - 'tabpaint']}, 08:44:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['tsvgx', 08:44:07 INFO - 'tsvgr_opacity', 08:44:07 INFO - 'tart', 08:44:07 INFO - 'tscrollx', 08:44:07 INFO - 'cart']}, 08:44:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:07 INFO - 'tsvgr_opacity', 08:44:07 INFO - 'tart', 08:44:07 INFO - 'tscrollx', 08:44:07 INFO - 'cart']}, 08:44:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'talos_options': ['--disable-e10s'], 08:44:07 INFO - 'tests': ['tp5o']}, 08:44:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'tests': ['tp5o']}, 08:44:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'talos_options': ['--disable-e10s', 08:44:07 INFO - '--xperf_path', 08:44:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:07 INFO - 'tests': ['tp5n']}, 08:44:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:07 INFO - 'talos_options': ['--xperf_path', 08:44:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:07 INFO - 'tests': ['tp5n']}}, 08:44:07 INFO - 'talos.zip': {'path': '', 08:44:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:07 INFO - Running post-action listener: _resource_record_post_action 08:44:07 INFO - ##### 08:44:07 INFO - ##### Running create-virtualenv step. 08:44:07 INFO - ##### 08:44:07 INFO - Running pre-action listener: _resource_record_pre_action 08:44:07 INFO - Running main action method: create_virtualenv 08:44:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:44:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:07 INFO - Using real prefix '/tools/python27' 08:44:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:11 INFO - Installing pip.................done. 08:44:11 INFO - Return code: 0 08:44:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44: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:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:11 INFO - 'HOME': '/Users/cltbld', 08:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:11 INFO - 'LOGNAME': 'cltbld', 08:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:11 INFO - 'MOZ_NO_REMOTE': '1', 08:44:11 INFO - 'NO_EM_RESTART': '1', 08:44:11 INFO - 'PAGER': '/bin/cat', 08:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:11 INFO - 'PWD': '/builds/slave/test', 08:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:11 INFO - 'SHELL': '/bin/bash', 08:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:11 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:11 INFO - 'USER': 'cltbld', 08:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:11 INFO - 'XPC_FLAGS': '0x0', 08:44:11 INFO - 'XPC_SERVICE_NAME': '0', 08:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:44:11 INFO - Cleaning up... 08:44:11 INFO - Return code: 0 08:44:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:44: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:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:11 INFO - 'HOME': '/Users/cltbld', 08:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:11 INFO - 'LOGNAME': 'cltbld', 08:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:11 INFO - 'MOZ_NO_REMOTE': '1', 08:44:11 INFO - 'NO_EM_RESTART': '1', 08:44:11 INFO - 'PAGER': '/bin/cat', 08:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:11 INFO - 'PWD': '/builds/slave/test', 08:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:11 INFO - 'SHELL': '/bin/bash', 08:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:11 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:11 INFO - 'USER': 'cltbld', 08:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:11 INFO - 'XPC_FLAGS': '0x0', 08:44:11 INFO - 'XPC_SERVICE_NAME': '0', 08:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:12 INFO - Downloading/unpacking psutil>=0.7.1 08:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:15 INFO - Installing collected packages: psutil 08:44:15 INFO - Running setup.py install for psutil 08:44:15 INFO - building 'psutil._psutil_osx' extension 08:44:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:44:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:44:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:44:15 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:44:16 INFO - building 'psutil._psutil_posix' extension 08:44:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:44:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:44:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:44:16 INFO - ^ 08:44:16 INFO - 1 warning generated. 08:44:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:44:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:16 INFO - Successfully installed psutil 08:44:16 INFO - Cleaning up... 08:44:16 INFO - Return code: 0 08:44:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:16 INFO - 'HOME': '/Users/cltbld', 08:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:16 INFO - 'LOGNAME': 'cltbld', 08:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:16 INFO - 'MOZ_NO_REMOTE': '1', 08:44:16 INFO - 'NO_EM_RESTART': '1', 08:44:16 INFO - 'PAGER': '/bin/cat', 08:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:16 INFO - 'PWD': '/builds/slave/test', 08:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:16 INFO - 'SHELL': '/bin/bash', 08:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:16 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:16 INFO - 'USER': 'cltbld', 08:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:16 INFO - 'XPC_FLAGS': '0x0', 08:44:16 INFO - 'XPC_SERVICE_NAME': '0', 08:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:44:19 INFO - Installing collected packages: mozsystemmonitor 08:44:19 INFO - Running setup.py install for mozsystemmonitor 08:44:19 INFO - Successfully installed mozsystemmonitor 08:44:19 INFO - Cleaning up... 08:44:19 INFO - Return code: 0 08:44:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44: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:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:19 INFO - 'HOME': '/Users/cltbld', 08:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:19 INFO - 'LOGNAME': 'cltbld', 08:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:19 INFO - 'MOZ_NO_REMOTE': '1', 08:44:19 INFO - 'NO_EM_RESTART': '1', 08:44:19 INFO - 'PAGER': '/bin/cat', 08:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:19 INFO - 'PWD': '/builds/slave/test', 08:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:19 INFO - 'SHELL': '/bin/bash', 08:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:19 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:19 INFO - 'USER': 'cltbld', 08:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:19 INFO - 'XPC_FLAGS': '0x0', 08:44:19 INFO - 'XPC_SERVICE_NAME': '0', 08:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:44: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:44: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:44: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:44: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:44: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:44: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:44:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:23 INFO - Downloading docopt-0.6.1.tar.gz 08:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:23 INFO - Running setup.py install for blobuploader 08:44:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:23 INFO - Running setup.py install for requests 08:44:23 INFO - Running setup.py install for docopt 08:44:24 INFO - Successfully installed blobuploader requests docopt 08:44:24 INFO - Cleaning up... 08:44:24 INFO - Return code: 0 08:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44: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:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:24 INFO - 'HOME': '/Users/cltbld', 08:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:24 INFO - 'LOGNAME': 'cltbld', 08:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:24 INFO - 'MOZ_NO_REMOTE': '1', 08:44:24 INFO - 'NO_EM_RESTART': '1', 08:44:24 INFO - 'PAGER': '/bin/cat', 08:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:24 INFO - 'PWD': '/builds/slave/test', 08:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:24 INFO - 'SHELL': '/bin/bash', 08:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:24 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:24 INFO - 'USER': 'cltbld', 08:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:24 INFO - 'XPC_FLAGS': '0x0', 08:44:24 INFO - 'XPC_SERVICE_NAME': '0', 08:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-UTBjcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-OdUOCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-D4CFPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-2BxrS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-naebfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:24 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-O7m3oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MSS7pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ssTqEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GF9iro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4j5D3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-YDZhER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-sXU99R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-XXdbCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Er9Ae9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZcJvRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:25 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-UqWPjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:26 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-X96WZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:26 INFO - Running setup.py install for manifestparser 08:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:26 INFO - Running setup.py install for mozcrash 08:44:26 INFO - Running setup.py install for mozdebug 08:44:26 INFO - Running setup.py install for mozdevice 08:44:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:26 INFO - Running setup.py install for mozfile 08:44:26 INFO - Running setup.py install for mozhttpd 08:44:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Running setup.py install for mozinfo 08:44:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Running setup.py install for mozInstall 08:44:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Running setup.py install for mozleak 08:44:27 INFO - Running setup.py install for mozlog 08:44:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Running setup.py install for moznetwork 08:44:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:27 INFO - Running setup.py install for mozprocess 08:44:27 INFO - Running setup.py install for mozprofile 08:44:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:28 INFO - Running setup.py install for mozrunner 08:44:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:28 INFO - Running setup.py install for mozscreenshot 08:44:28 INFO - Running setup.py install for moztest 08:44:28 INFO - Running setup.py install for mozversion 08:44:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:28 INFO - Cleaning up... 08:44:28 INFO - Return code: 0 08:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:28 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 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:28 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:44:28 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:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:28 INFO - 'HOME': '/Users/cltbld', 08:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:28 INFO - 'LOGNAME': 'cltbld', 08:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:28 INFO - 'MOZ_NO_REMOTE': '1', 08:44:28 INFO - 'NO_EM_RESTART': '1', 08:44:28 INFO - 'PAGER': '/bin/cat', 08:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:28 INFO - 'PWD': '/builds/slave/test', 08:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:28 INFO - 'SHELL': '/bin/bash', 08:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:28 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:28 INFO - 'USER': 'cltbld', 08:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:28 INFO - 'XPC_FLAGS': '0x0', 08:44:28 INFO - 'XPC_SERVICE_NAME': '0', 08:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-X91ppe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-YkMlfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-QJq0sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-jfJZ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-EZu2bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-rwt5yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-a7RUoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8ursiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:29 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ezJKWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-_9L7EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8EFuOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-F6_xtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-kAMevY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:30 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:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-BMfwnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:30 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:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-0VzUBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:30 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:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-h0XRX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:30 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:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:30 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-slibOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:30 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:44:30 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:44:30 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:44:30 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:44:30 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:44:30 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:44:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44: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:44: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:44: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:44: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:44: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:44: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:44:33 INFO - Downloading blessings-1.6.tar.gz 08:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:33 INFO - Installing collected packages: blessings 08:44:33 INFO - Running setup.py install for blessings 08:44:33 INFO - Successfully installed blessings 08:44:33 INFO - Cleaning up... 08:44:33 INFO - Return code: 0 08:44:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:33 INFO - Reading from file tmpfile_stdout 08:44:33 INFO - Current package versions: 08:44:33 INFO - blessings == 1.6 08:44:33 INFO - blobuploader == 1.2.4 08:44:33 INFO - docopt == 0.6.1 08:44:33 INFO - manifestparser == 1.1 08:44:33 INFO - mozInstall == 1.12 08:44:33 INFO - mozcrash == 0.17 08:44:33 INFO - mozdebug == 0.1 08:44:33 INFO - mozdevice == 0.48 08:44:33 INFO - mozfile == 1.2 08:44:33 INFO - mozhttpd == 0.7 08:44:33 INFO - mozinfo == 0.9 08:44:33 INFO - mozleak == 0.1 08:44:33 INFO - mozlog == 3.1 08:44:33 INFO - moznetwork == 0.27 08:44:33 INFO - mozprocess == 0.22 08:44:33 INFO - mozprofile == 0.28 08:44:33 INFO - mozrunner == 6.11 08:44:33 INFO - mozscreenshot == 0.1 08:44:33 INFO - mozsystemmonitor == 0.0 08:44:33 INFO - moztest == 0.7 08:44:33 INFO - mozversion == 1.4 08:44:33 INFO - psutil == 3.1.1 08:44:33 INFO - requests == 1.2.3 08:44:33 INFO - wsgiref == 0.1.2 08:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:33 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 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:33 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:44:33 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:44:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:33 INFO - 'HOME': '/Users/cltbld', 08:44:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:33 INFO - 'LOGNAME': 'cltbld', 08:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:33 INFO - 'MOZ_NO_REMOTE': '1', 08:44:33 INFO - 'NO_EM_RESTART': '1', 08:44:33 INFO - 'PAGER': '/bin/cat', 08:44:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:33 INFO - 'PWD': '/builds/slave/test', 08:44:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:33 INFO - 'SHELL': '/bin/bash', 08:44:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:33 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:33 INFO - 'USER': 'cltbld', 08:44:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:33 INFO - 'XPC_FLAGS': '0x0', 08:44:33 INFO - 'XPC_SERVICE_NAME': '0', 08:44:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:44:34 INFO - Cleaning up... 08:44:34 INFO - Return code: 0 08:44:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:34 INFO - 'HOME': '/Users/cltbld', 08:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:34 INFO - 'LOGNAME': 'cltbld', 08:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:34 INFO - 'MOZ_NO_REMOTE': '1', 08:44:34 INFO - 'NO_EM_RESTART': '1', 08:44:34 INFO - 'PAGER': '/bin/cat', 08:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:34 INFO - 'PWD': '/builds/slave/test', 08:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:34 INFO - 'SHELL': '/bin/bash', 08:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:34 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:34 INFO - 'USER': 'cltbld', 08:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:34 INFO - 'XPC_FLAGS': '0x0', 08:44:34 INFO - 'XPC_SERVICE_NAME': '0', 08:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:34 INFO - Downloading/unpacking jsonschema 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:37 INFO - warning: no files found matching '*.txt' 08:44:37 INFO - no previously-included directories found matching 'build' 08:44:37 INFO - no previously-included directories found matching 'dist' 08:44:37 INFO - no previously-included directories found matching '.git*' 08:44:37 INFO - Installing collected packages: jsonschema, functools32 08:44:37 INFO - Running setup.py install for functools32 08:44:37 INFO - warning: no files found matching '*.txt' 08:44:37 INFO - no previously-included directories found matching 'build' 08:44:37 INFO - no previously-included directories found matching 'dist' 08:44:37 INFO - no previously-included directories found matching '.git*' 08:44:37 INFO - Successfully installed jsonschema functools32 08:44:37 INFO - Cleaning up... 08:44:37 INFO - Return code: 0 08:44:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:44:37 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:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:37 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:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:37 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 0x100b55a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b65420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa378cd8a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, '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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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:44:37 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:44:37 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:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:37 INFO - 'HOME': '/Users/cltbld', 08:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:37 INFO - 'LOGNAME': 'cltbld', 08:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:37 INFO - 'MOZ_NO_REMOTE': '1', 08:44:37 INFO - 'NO_EM_RESTART': '1', 08:44:37 INFO - 'PAGER': '/bin/cat', 08:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:37 INFO - 'PWD': '/builds/slave/test', 08:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:37 INFO - 'SHELL': '/bin/bash', 08:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:44:37 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:37 INFO - 'USER': 'cltbld', 08:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:37 INFO - 'XPC_FLAGS': '0x0', 08:44:37 INFO - 'XPC_SERVICE_NAME': '0', 08:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:37 INFO - Downloading/unpacking flake8 08:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:44:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:44:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:41 INFO - no previously-included directories found matching 'docs/_build' 08:44:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:44:41 INFO - Running setup.py install for pep8 08:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:41 INFO - no previously-included directories found matching 'docs/_build' 08:44:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:44:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:44:41 INFO - Cleaning up... 08:44:41 INFO - Return code: 0 08:44:41 INFO - Running post-action listener: _resource_record_post_action 08:44:41 INFO - Running post-action listener: _start_resource_monitoring 08:44:41 INFO - Starting resource monitoring. 08:44:41 INFO - ##### 08:44:41 INFO - ##### Running install step. 08:44:41 INFO - ##### 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: install 08:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:42 INFO - Reading from file tmpfile_stdout 08:44:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:42 INFO - Reading from file tmpfile_stdout 08:44:42 INFO - Output received: 08:44:42 INFO - Usage: mozinstall [options] installer 08:44:42 INFO - Options: 08:44:42 INFO - -h, --help show this help message and exit 08:44:42 INFO - -d DEST, --destination=DEST 08:44:42 INFO - Directory to install application into. [default: 08:44:42 INFO - "/builds/slave/test"] 08:44:42 INFO - --app=APP Application being installed. [default: firefox] 08:44:42 INFO - mkdir: /builds/slave/test/build/application 08:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:45:15 INFO - Reading from file tmpfile_stdout 08:45:15 INFO - Output received: 08:45:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:45:15 INFO - Running post-action listener: _resource_record_post_action 08:45:15 INFO - ##### 08:45:15 INFO - ##### Running run-tests step. 08:45:15 INFO - ##### 08:45:15 INFO - Running pre-action listener: _resource_record_pre_action 08:45:15 INFO - Running main action method: run_tests 08:45:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:45:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:45:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:45:15 INFO - 2016-04-21 08:45:15.522 screenresolution[1644:7557] starting screenresolution argv=screenresolution get 08:45:15 INFO - 2016-04-21 08:45:15.524 screenresolution[1644:7557] Display 0: 1600x1200x32@60 08:45:15 INFO - 2016-04-21 08:45:15.530 screenresolution[1645:7559] starting screenresolution argv=screenresolution list 08:45:15 INFO - Available Modes on Display 0 08:45:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:45:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:45:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:45:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:45:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:45:15 INFO - Intel Iris: 08:45:15 INFO - Chipset Model: Intel Iris 08:45:15 INFO - Type: GPU 08:45:15 INFO - Bus: Built-In 08:45:15 INFO - VRAM (Dynamic, Max): 1536 MB 08:45:15 INFO - Vendor: Intel (0x8086) 08:45:15 INFO - Device ID: 0x0a2e 08:45:15 INFO - Revision ID: 0x0009 08:45:15 INFO - Displays: 08:45:15 INFO - Display: 08:45:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:45:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:45:15 INFO - Display Serial Number: 1600x1200 60 08:45:15 INFO - Main Display: Yes 08:45:15 INFO - Mirror: Off 08:45:15 INFO - Online: Yes 08:45:15 INFO - Rotation: Supported 08:45:15 INFO - Return code: 0 08:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:15 INFO - Python 2.7.3 08:45:15 INFO - Return code: 0 08:45:15 INFO - grabbing minidump binary from tooltool 08:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:15 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 0x1009f4e00>, '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 0x10081ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009efb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:15 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:45:15 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:45:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:15 INFO - Return code: 0 08:45:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:45:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:45:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:45:17 INFO - Return code: 0 08:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --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:45:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uKdIQ3rlx2/Render', 08:45:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:17 INFO - 'HOME': '/Users/cltbld', 08:45:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:17 INFO - 'LOGNAME': 'cltbld', 08:45:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:17 INFO - 'MOZ_NO_REMOTE': '1', 08:45:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:17 INFO - 'NO_EM_RESTART': '1', 08:45:17 INFO - 'PAGER': '/bin/cat', 08:45:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:17 INFO - 'PWD': '/builds/slave/test', 08:45:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:17 INFO - 'SHELL': '/bin/bash', 08:45:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0c4Nxm76eO/Listeners', 08:45:17 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 08:45:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:17 INFO - 'USER': 'cltbld', 08:45:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:17 INFO - 'XPC_FLAGS': '0x0', 08:45:17 INFO - 'XPC_SERVICE_NAME': '0', 08:45:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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:45:17 INFO - mozversion application_buildid: 20160421071514 08:45:17 INFO - mozversion application_changeset: 9073060fceb054ed745bec841a904caaf68bfa02 08:45:17 INFO - mozversion application_display_name: Nightly 08:45:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:17 INFO - mozversion application_name: Firefox 08:45:17 INFO - mozversion application_remotingname: firefox 08:45:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:45:17 INFO - mozversion application_vendor: Mozilla 08:45:17 INFO - mozversion application_version: 48.0a1 08:45:17 INFO - mozversion platform_buildid: 20160421071514 08:45:17 INFO - mozversion platform_changeset: 9073060fceb054ed745bec841a904caaf68bfa02 08:45:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:45:17 INFO - mozversion platform_version: 48.0a1 08:45:17 INFO - using testdate: 1461253517 08:45:17 INFO - actual date: 1461253517 08:45:17 INFO - starting webserver on 'localhost:49278' 08:45:17 INFO - SUITE-START | Running 2 tests 08:45:17 INFO - TEST-START | dromaeo_css 08:45:17 INFO - operating with platform_type : mac_ 08:45:17 INFO - Initialising browser for dromaeo_css test... 08:45:17 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpk2t6lr/profile http://localhost:49278/getInfo.html) 08:45:19 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:45:19 INFO - PROCESS | 1663 | colorDepth:24 08:45:19 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:45:19 INFO - PROCESS | 1663 | __metrics 08:45:19 INFO - PROCESS | 1663 | 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:45:19 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:45:20 INFO - TEST-INFO | 1663: exit 0 08:45:20 INFO - Browser initialized. 08:45:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:20 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpk2t6lr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:32 INFO - PROCESS | 1665 | RSS: Main: 238936064 08:45:32 INFO - PROCESS | 1665 | 08:46:23 INFO - PROCESS | 1665 | 1461253583929 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:48:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 08:48:35 INFO - PROCESS | 1665 | RSS: Main: 374476800 08:48:35 INFO - PROCESS | 1665 | 08:51:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 08:51:39 INFO - PROCESS | 1665 | RSS: Main: 379944960 08:51:39 INFO - PROCESS | 1665 | 08:54:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 08:54:42 INFO - PROCESS | 1665 | RSS: Main: 377163776 08:54:42 INFO - PROCESS | 1665 | 08:57:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 08:57:45 INFO - PROCESS | 1665 | RSS: Main: 375115776 08:57:45 INFO - PROCESS | 1665 | 09:00:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 09:00:48 INFO - PROCESS | 1665 | RSS: Main: 348360704 09:00:48 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 09:03:52 INFO - PROCESS | 1665 | RSS: Main: 381784064 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | __start_tp_report 09:03:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:03:52 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:03:52 INFO - PROCESS | 1665 | |i|pagename|runs| 09:03:52 INFO - PROCESS | 1665 | |0;dojo.html;3409.488576713493;3470.600880898696;3498.1254686328416;3502.5446691930047;3535.6464353564647;5695.117256825193;5695.288088988877;5700.486956173943;5730.05454100073;5755.1942728018;5736.053551164053;5751.223584816049;5851.941480585193;5887.941120588793;5890.116482527612;5131.820386286481;5175.016746818102;5203.661761985478;5214.400343960455;5272.762725677354;5254.080535906221;5309.5752339812725;5326.014687282865;5334.466553344654;5382.1926710993275;4288.206681763883;5145.922811157836;5155.922661160085;5231.973840130775;5278.076336641092;5197.7920883164625;5238;5240.659357141773;5251.159814429673;5259.737013149365;5170.405403378622;5177.404598471148;5203.739813009334;5208.583313334924;5229.2156176573435;5592.552595792326;5689.630174038674;5702.116171993348;5709.800156994527;5710.600257981943;6179.969100154515;6260.812175634738;6289.088082228097;6293.527985401113;6299.149614801989;6227.408396202353;6287.056941458772;6308.2745484269435;6313.558050936436;6315.305316415191;5658.207850900877;5769.249997500298;5793.8551536211935;5798.159266906275;5798.768049278024;6288.088227207121;6335.493160547145;6361.395667411589;6363.681815909186;6365.458935990493;6155.35368786271;6166.4758495527485;6178.165947597106;6182.258129024546;6229.875402491924;6124.258880972529;6205.782797602063;6215.96892015537;6305.716242769086;6307.653079080603;6215.378462153839;6245.937540624535;6250.531210159256;6253.624782513064;6274.6548939808745;4894.461609222983;6233.781817636361;6270.059491076284;6275.905861412082;6277.309495955441;4825.686330388514;4909.140900342426;4913.70517768935;4928.186849169919;4945.109880221595;4355.346697995326;4394.384786129945;4401.427814384174;4404;4420.138073075719;4926.581240594518;5294.073537130987;5516.586256030814;5528.972355138279;5543.944560554423;5758.280214973129;6119.929102025404;6183.783567575113;6302.243730752339;6307.211598550181;5666.575006874418;5668.688222147822;5673.659580425187;5696.8006119785605;5713.143028545752;5399.676019438846;5411.053065713484;5411.83764487066;5412.945870541244;5417.512423881791;5387.461253874581;6252.656103914237;6303.401176888188;6428.325025872216;6432.678366081771;6262.15460912771;6269.153664255267;6282;6287.74849006053;6288.0882272069375;6245.812625621239;6354.936450635434;6357.745690172342;6389.073584330153;6391.488680905423;6124.594542075297;6169.290531588746;6233;6239.438450539473;6243.500519958483;5046.571041461517;5291.656042357235;6206.224221972254;6263.4362907338555;6266.373362663697;5154.845354639367;5163.612729045261;6006.639601623917;6130.601510901777;6163.784267550794;6136.592867771182;6140.03518873956;6141.271221159771;6143;6150.261968563801;5961.225040744675;5996.730147143477;5998.610090344114;6009.278886533644;6024.0662697282;5822.126680997884;5899.616524925866;5910.970445147746;6151.815445536641;6159.84600384994;5974.790882319272;5980;5996.400359964143;6013.849653758691;6033.879322413615 09:03:52 INFO - PROCESS | 1665 | |1;ext.html;518.9792408303667;529.8357509172155;588.6497533967289;589.6727316339435;619.108483783352;24481.510369792595;31231;31240.21899452512;31259.374812503764;39299.803500982525;42946.570534294726;43752.343714844304;43760.562394376044;43783.34324985128;43837.78081109598;9466.38468499547;9698.9515052425;9701.223902087817;9709.660161894335;9711.660091896785;8753;9013.098690131;9025.007249202616;9726.319157658967;9877;8841.425307355034;8923.553822308892;9788.510574471284;11670;11916.10629202809;11564.768704625902;11697.473613687362;11698.005669518016;11705.473253703603;11732.824007639892;8697.304215662733;9732;11511.136664750176;11680.883191168065;11684.357360345177;41776;42628.57371426277;42642.57357426417;42714;42805.14389712188;3259.6903294187014;3376.3922493951077;3405.625381208065;3528.576570811493;3563.0914116900285;28924.27689307763;29212.70787292121;29461.852690736625;29880.40239195204;29888;2724.4278701472713;2728.3042824079735;2743.396452780385;2779.3051737065734;2822.985885070582;398426;399633;400322;400696;401964;35970.92087237387;36828;36898.63101369006;36904.89285321391;62204.75590488256;36317.636823631954;36453.81773091118;36543.269134617156;36553.08617284536;36590.8170459146;14298.356573954197;14484.275786210857;14500.927495362455;14537.854621453862;14542.272886355851;12193.573224937085;12242.632721018384;12263.325517096646;12280.508779648713;12594.87405125937;7721.189275126143;7933.444658873939;8304.460210086447;8358.498490090615;8422.578871056423;3373.241020770307;3468.236987862666;3471.531343268626;3471.7743346682387;3503.964960350415;848.1221935297061;918.609590923868;952.5094576293214;954.1841725324886;990.9900900990898;29146.7085329144;29640.664680357313;29683.554746678816;29883.530445900295;30040.399192016474;1136.477220478589;1154.878737732526;1183.2131632464486;1217.9025677945742;1249.4564864284066;15754.975926564737;15836.970596911164;15849.969751966086;15956;16238.431654892021;630354;642297;642776;642804;642997;52365.7381713089;63400.682996585645;64293.35706642967;64314;64392.67803660952;1467.9779803302958;1505.0668585477074;1514.719776841266;1516.7876497290388;1517.582664767198;26764.330891727084;26992.190234293004;27195.86402068056;27527.449451011267;27623.72376276292;55921.16118258148;56572;57217.427825721206;57219;57441.71279143745;574061;577036;577596;577805;578383;19891.701624475932;26853.865730671223;27213;27669.16992490148;27850.582241266802;43584.56415435805;44458.777706111265;44564.331535027646;45346.773266134776;45741.542584573726;37706.8114659425;38654.61345386622;38721.80639096787;40008;40619.7969010153;37758.244835102596;37878.8106059468;37944.62055379521;38820.41769373405;38894.6110538891;38764.41853372145;38810.02974925649;39720.801395992836;40636.1872762549;40687.1862562753;27232.455350893266;30382.54426183653;33647.663523364456;33917.8128765492;34396.65603343934;22197.889010554845;23601.168118523838;25281;25683.486330273663;25808.870955645103 09:03:52 INFO - PROCESS | 1665 | |2;jquery.html;396.5934916710372;396.82143035633965;397.6838413461298;400.51737656124357;408.92843752343333;19296;19914;20260.493487662814;20285.39143825686;20418.59162816743;19815.603687926232;20704.792952070475;20935.895320523377;21516.462088447795;21541;5783.5951483396175;5867.735951882154;6119.418655227746;6128.724207410677;6131.110988906606;5585.609007369486;5945.16767652529;6026.126211699301;6052.122442245872;6055;5916.408359164092;5922.141289513018;5947.910781338283;5951.494122999528;5953.3748956359605;5945.702714864261;5962.314333851597;6058.363871793486;6571.408573228432;6572.835679108012;5851.64890106595;5862.941370586283;5869.413058694139;5884.941150588482;5892.675902825343;15937.681246375008;21478.57042859134;25751.96992120313;26943.73056269432;26948.326291842666;2081.5940891526157;2107.6311645462138;2133.4879628888957;2273.3975496493445;2752.926358720101;9602.183814375787;9812.411255324632;10094.29339946204;10699.518521666543;15285;1685.6207353345521;1775.520609435458;1776.786785585738;1797.5595978985102;1808.6292310076403;85364;89484;120030;127340;128099.35950320282;8129.593520323961;10571.894281057092;11399.48702308398;11634.418279086012;11752.76494470123;15145.318460669296;15228;15243.08541487492;15271.618209544627;15285.312160952784;7599.202083781234;7999.600119963988;8014.759557213293;8033.718819841394;8372.358024259467;7225.349718525358;7679.424043196783;7947.086085100287;8012.238837310446;8114.350851931831;4492.3935268738305;4554.0891821635805;4561.407017087824;4609.700369475973;4641.86074417768;1907.2085084689697;1976.9209231630862;1980.5048737815546;1981.2570286142698;1982.3359174676646;865.4201684871151;936.8782058332373;965.8454647256406;1006.0191313469309;1037.5642230263309;20297.594048118954;20701.68947465789;20805.479863003242;21018.684719729215;21032.579348412946;953.666216824106;964.4647220792527;991.0634450444261;997.0876647867266;1016.8220561401725;10821.729456763644;10991;11011.504482298316;11033.668989930315;11066.723331916766;595426;596407;606042;613959.0228684038;614018.7196256139;93366;115822;122101.77898220904;126384;130850;988.8961659025842;1012.0790081026231;1023.3757407980977;1030.2273295028729;1032.3599368391644;16191.676166476369;17652.558686032437;18125.27498900082;18540.629187416445;19003.71494427557;43064.13871722611;44389.66830995075;51449;52049.21926171035;52295.73852130715;74692.62653686697;75400;76262;76869.23130768845;76920.46159076899;7678.721111244198;8089.2315230053055;8099.595020249082;8368.45605035695;8471.95764021176;9147.725568232963;11808.586699465477;12434.56479023266;12655.557055503014;12925.15986460877;10904.836427453753;10908.78401858691;10967.232293739362;11010.528730816664;11231.326120432801;10635.096016838655;10865.456727163768;10963.287386319864;11244.493997769956;11269.943650282024;9691.70924872255;11052.778944420907;11141.554337826396;11212.046976006804;11467.139964502529;6731.259561448334;7960.164182760726;8338.332933365438;8367.916320836714;8486.70296539643;8841;10794.784104317712;10959.506822192861;10994.890051099386;11247.943760281147 09:03:52 INFO - PROCESS | 1665 | |3;mootools.html;1422.0969684250497;1595.5452695981644;1599.6720672262184;1877.6244751049785;2002.2391491233338;7888.605569721512;8545.23092921637;8757.25563327118;8758.211760941505;8772.254358379529;8410.663573457054;8638.913610863889;8644.913550864489;8649.221570058693;8650.134986501347;1920.7310976463307;2141.1863491873146;2380.3929997850523;2423.4183795889035;2453.4479742058074;2067.4727944374163;2422.2248880358293;2444.69441319835;2461.6184491403774;2464.2484042367073;2409.084547871806;2420.9636855447184;2465.5315490056832;2466.5560199164142;2469.086438017936;2141.68945502902;2390.127603424755;2433.5254625348066;2471.938201544958;2474.8391354562077;2459.1515927005153;2468;2489.5394352044927;2489.676342075537;2492.0779311654624;8553.786155346104;8695.869561956575;8696.913030869737;8707;8708.825823483558;5182.4299327073995;5356.062689029443;5366.731663416814;5372.382176049765;5378.139497680391;2898.1740204041957;3497.6327485613897;3544.1848374873666;3544.4860495228304;3549;1001.3441196016548;1016.9644062457852;1020.336781092296;1026.0662796854826;1026.5637104230748;11513.539458421654;11527.962483376536;11533.077353811675;11535.423228838525;11540.134489913291;3831.9233615328094;4178.456800615962;4681.250999840009;4721.504242054603;4885.438174609965;9791.510424478747;9929.900700993043;9942.353747006422;9950.751231219132;9961;5385.461453854661;5400.135978243462;5406.351237851483;5430.755615997289;5440.238366628675;4260.6378457830815;4412.646988240933;4507.639388848885;4578.6794924355645;4578.9771051144535;3327.866885324608;3424.1610805352348;3974.813852381179;4108.014076621649;4112.300908845504;1295.430010795247;1320.8877245434053;1321.4780161836213;1338.3910320804011;1342.4697244588333;908.232543500754;926.3145272498438;927.2396634759567;938.5072836760619;969.5491596407704;4925.901481970341;5639.887202255932;5843.357230704619;5934.970325148433;6031;438.0887753472769;446.2703479810533;451.09780439121755;462.1888585532436;465.77177183180675;3894.1627550076305;3993.880183594497;4055.1484188320783;4068.4710987571425;4069.328560787496;10030.047145521165;10516.053555179917;10776.515056822462;10908.50911708975;10924;10476.63331783384;10477.266591338534;10500.474976251156;10503.264771466076;10608;7430.736774748306;7578.621068946641;7865.567393793282;7915.881261781078;8151.8777218341775;5812.796552120655;5958.880822383441;5965.308976228096;5977.163197152315;6033.0045542484995;9775.608975640895;9855.802883942137;9883.159931405911;9961.35251208669;9967.202623789934;8383.329333653171;10053.447060411747;10079.596816127272;10111.24165687591;10215.38707677512;6912.758053468105;7131.82170445743;7158.212596614264;7178.353948144692;7301.926980730337;7763.805904852198;8113.797155071171;8358.289545388467;8368.24685778283;8377.120402357908;7175.964120179575;7350.154732205651;7429.591372474566;7443.516171448839;7507.286807753255;7169.426445884213;7241.45689073311;7247.927520724726;7366.484346095722;7401.1488678802625;6947.756828510978;7003.7548685795755;7015.158181018311;7016.473764467583;7031;4817.494163112823;4898.436679781728;4966.751662416792;5033.345665063518;5163.612729045261;4928.408590969107;4945.455999839943;5068.417132029864;5089.931114466003;5300.946990530046 09:03:52 INFO - PROCESS | 1665 | |4;prototype.html;273.6674939947963;308.39708370136384;318.59538386249466;326.53631842783244;328.7123766704134;4883.6337274704365;5705.087186050222;5827.4463925927075;5852.297724273088;5866.530677545797;4500.5724456176695;5211.348581427322;5580.693061881595;5667.206591077253;5807.912881306784;3960.7919584526708;4134.276501612221;4323.675724320673;4392.582704643054;4399.120175964804;4390.297552391618;4403.537628549005;4404.4054052702795;4409.757463339515;4427.409965170379;3140.7801453898237;3790.886273411802;4255.425492567754;4290.377895205193;4298.78506074695;3485.3203625293204;3696.6672999430048;4248.022954720432;4261.105167914741;4284.507281662618;3668.981655091734;3673.81630918453;3683.889483315505;3684.7604905681046;3699.130704284491;4815.036992601459;5220.269162317279;5283.260343551906;5509.972450137724;5515.393306736256;4890.926636100461;4911.50884911506;4947.826826061107;4960.826371076995;4983.825566105205;6028.427299406593;6046.576739628228;6061.454469097758;6079.90561698894;6088.512918966472;3890.3580909149955;4049.3521036633997;4053.1285773558825;4077.1234184650443;4078.9184216315803;5487.286652735119;6217.880781459336;6349.714262858136;6425.389587989133;6431.839204019937;3934.311495488278;4010.7593544386846;4127.8422007164545;4129.69027322952;4134.710570260053;3487.372272990886;3868.9806550967064;4027.1448385178965;4197.139586384784;4197.18154959786;4181;4864.70811751289;4886.486918873538;4895.853124406273;4928.704277743347;5495.763453223073;5709.914351284734;6104.908426373608;6122.632642041492;6133.907991380132;1308.9149205301815;1382.9930850345684;1435.8133442652597;1435.956921292363;1457.0820383158543;877.9517126558101;942.359195746885;966.9274804389698;968.25444407807;970.2383628851318;4737.739424331695;5650.208970744099;5727.77088916447;5738.99567575681;5745.931464672714;5298.81454149103;6039.761848820981;6426.550141490051;6435.106760409884;6452.806415807533;5766.4233576642;5772.884542309214;5808.941910580925;5831.329397119385;5831.4168583141345;2861.8139820911574;3348.8827891024184;3405.506201600754;3410.23269764306;3425.4071856586806;5216;6525.694861027719;6617.437517810944;6776.2546119926765;6783.423409010191;6560.442362399154;6570.507211959122;6666.233383160901;6693.397594216543;6697.866042679119;5788.9290481261105;5831.941680583224;5885.439833672366;6482.416582507597;6798.125068710886;5420.972895135499;5618.718404699569;6296.198191804786;6463.676816159267;6470.708818103102;6040.946078333388;6343.11196432509;6354.015127655221;6367.745290188341;6367.936320636734;5489.313835770528;6642.634655094016;6796.66016699173;6814.182298124257;6842.213145488333;3531.3643544162296;4181.623653871045;4214.662826973896;4218.55705150967;4241.724287921399;4969.503049695146;5780.219670344618;6166.290876549254;6443.96778016107;6476.222853257639;5296.470352964673;5662.915056274242;5857.765689372377;6227.439530442282;6247.562670613013;5855.531557475307;5966.582339236212;6206.10011548332;6233.844153896189;6255.937440625536;5108.66793658411;5372.62391632582;5949.881002380015;6073.180120683651;6144.907826382519;5473.01485732556;5988.6706231157705;6252.218472690914;6272.247330320209;6279.510150242599;5042.495750424928;6117.418845209698;6139.140520327069;6145.508359331154;6163.9383606163365 09:03:52 INFO - PROCESS | 1665 | |5;yui.html;654.5679851298144;674.7773234832506;722.3174100475053;729.0340299103689;730.4886579394425;14678;14691.265436728148;15071.62320941977;15131.394744210233;15387.076775393483;13889.236092014935;14045.438182472715;14087.29563521825;14094.859051409483;14139.222342771143;597.3011576455557;621.546271222006;729.2634439216403;747.8766003609398;930.9022552631977;905.6920646980026;945.9337846350758;947.2800671489683;948.928830337724;949.2074118111351;951.2485136741966;993.2897977945768;993.746594618375;995.3579940938091;1000.6447711062577;762.3786613909646;961.6634178037701;983.4640121133999;987.6493844685177;987.9753006174831;724.1346590823968;730.393773168269;732.9670164842595;733.4609062339176;734.2327268004948;14987.32557034936;15109.320080596399;15113.622159445991;15123.546293611209;15126.848731512655;10403.479437875765;12368.567100151451;12684.746305073846;12745.490180392773;12951.028672849574;8571.89840491534;9945.850812237823;9949.115363380008;10145.898541014569;10146.898531014669;3456.1705190754037;3489.354469423165;3493;3542.822858857073;3554.537910071674;78670;79054.60472697657;79290.20709792885;79999;81951.5902420496;9562.378445401027;9704.563294651758;9739.707808765748;9940.80118397628;10095;18489;22328.441788955406;22399.88800055989;22403.32790016302;22431.21490747816;7197.388222001188;7286.417086633057;7310.4517161213125;7421.443391745533;7479.588622625699;3953.347697629859;4011.859584914572;4022.8591999279884;4023.155137421116;4026.074002979331;3539.2744487380023;3651.1784848409425;3656.3601369760186;3658.8902332929524;3669.082729317671;609.1776102261999;625.7403177681211;639.9936000640027;644.3395519592361;645.4158986117477;558.198984457297;565.6973519167308;571.6598623818821;584.6024703201779;610.703808652803;7777.72777952769;7969.282764551218;8062.269398025858;8095.3523718102415;8250.174982501821;536.7906516458585;581.9476247137778;582.8193260089386;586.5395664403422;636.6084857812505;3280.7867488613165;3301.5377847101427;3372.2412457197424;3785.466920827588;4014.759114453142;88243;90223.54888225517;91035;91523.54238228766;92020;77511.61244193742;77930;78140.6092969543;78261.60869195731;78301;66364.6681766588;68028.31971680319;68872.31127688759;69874.9518757219;70180.2981970184;7712.1516633169185;7727.265909738566;7818.85213232359;7853.958188843843;7899.0521137463875;31598.684013159575;38486;41265;43132.353014704175;45025.77487112543;47358.76320618375;47823.52176478191;56686;58149;65427.710030148715;11148.609798657008;11394.601188958346;11777.998870095795;11825.93566579012;12454.875451245372;11922.225055371373;12101.273923564615;12282.877171228174;12316.384180791103;12367.814482782585;11355.886441135814;11453.370064646191;11526.769464610494;11805;12024.398780060787;11158.497867595815;11185.552577897119;11355.091592672401;11433.371164586028;11729.941350293195;11374.54501819918;11435.59975400857;11835.526578936746;11869.287842729464;11950.760984780429;9421.623135074795;9592.856107158537;9663.565139568876;9928.652497162564;10244.590216391261;9657.170928253603;9704.175145112744;9735.561899714672;9802.852957205505;9879.851802222829 09:03:52 INFO - PROCESS | 1665 | __end_tp_report 09:03:52 INFO - PROCESS | 1665 | __start_cc_report 09:03:52 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1370 09:03:52 INFO - PROCESS | 1665 | __end_cc_report 09:03:52 INFO - PROCESS | 1665 | __startTimestamp1461254632296__endTimestamp 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:03:52 INFO - PROCESS | 1665 | Number of tests: 6 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5713.31 Median:5890.12 stddev:650.62 (11.0%) stddev-sans-first:627.01 09:03:52 INFO - PROCESS | 1665 | Values: 3409.5 3470.6 3498.1 3502.5 3535.6 5695.1 5695.3 5700.5 5730.1 5755.2 5736.1 5751.2 5851.9 5887.9 5890.1 5131.8 5175.0 5203.7 5214.4 5272.8 5254.1 5309.6 5326.0 5334.5 5382.2 4288.2 5145.9 5155.9 5232.0 5278.1 5197.8 5238.0 5240.7 5251.2 5259.7 5170.4 5177.4 5203.7 5208.6 5229.2 5592.6 5689.6 5702.1 5709.8 5710.6 6180.0 6260.8 6289.1 6293.5 6299.1 6227.4 6287.1 6308.3 6313.6 6315.3 5658.2 5769.2 5793.9 5798.2 5798.8 6288.1 6335.5 6361.4 6363.7 6365.5 6155.4 6166.5 6178.2 6182.3 6229.9 6124.3 6205.8 6216.0 6305.7 6307.7 6215.4 6245.9 6250.5 6253.6 6274.7 4894.5 6233.8 6270.1 6275.9 6277.3 4825.7 4909.1 4913.7 4928.2 4945.1 4355.3 4394.4 4401.4 4404.0 4420.1 4926.6 5294.1 5516.6 5529.0 5543.9 5758.3 6119.9 6183.8 6302.2 6307.2 5666.6 5668.7 5673.7 5696.8 5713.1 5399.7 5411.1 5411.8 5412.9 5417.5 5387.5 6252.7 6303.4 6428.3 6432.7 6262.2 6269.2 6282.0 6287.7 6288.1 6245.8 6354.9 6357.7 6389.1 6391.5 6124.6 6169.3 6233.0 6239.4 6243.5 5046.6 5291.7 6206.2 6263.4 6266.4 5154.8 5163.6 6006.6 6130.6 6163.8 6136.6 6140.0 6141.3 6143.0 6150.3 5961.2 5996.7 5998.6 6009.3 6024.1 5822.1 5899.6 5911.0 6151.8 6159.8 5974.8 5980.0 5996.4 6013.8 6033.9 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:66075.36 Median:36863.32 stddev:146985.01 (398.7%) stddev-sans-first:147314.93 09:03:52 INFO - PROCESS | 1665 | Values: 519.0 529.8 588.6 589.7 619.1 24481.5 31231.0 31240.2 31259.4 39299.8 42946.6 43752.3 43760.6 43783.3 43837.8 9466.4 9699.0 9701.2 9709.7 9711.7 8753.0 9013.1 9025.0 9726.3 9877.0 8841.4 8923.6 9788.5 11670.0 11916.1 11564.8 11697.5 11698.0 11705.5 11732.8 8697.3 9732.0 11511.1 11680.9 11684.4 41776.0 42628.6 42642.6 42714.0 42805.1 3259.7 3376.4 3405.6 3528.6 3563.1 28924.3 29212.7 29461.9 29880.4 29888.0 2724.4 2728.3 2743.4 2779.3 2823.0 398426.0 399633.0 400322.0 400696.0 401964.0 35970.9 36828.0 36898.6 36904.9 62204.8 36317.6 36453.8 36543.3 36553.1 36590.8 14298.4 14484.3 14500.9 14537.9 14542.3 12193.6 12242.6 12263.3 12280.5 12594.9 7721.2 7933.4 8304.5 8358.5 8422.6 3373.2 3468.2 3471.5 3471.8 3504.0 848.1 918.6 952.5 954.2 991.0 29146.7 29640.7 29683.6 29883.5 30040.4 1136.5 1154.9 1183.2 1217.9 1249.5 15755.0 15837.0 15850.0 15956.0 16238.4 630354.0 642297.0 642776.0 642804.0 642997.0 52365.7 63400.7 64293.4 64314.0 64392.7 1468.0 1505.1 1514.7 1516.8 1517.6 26764.3 26992.2 27195.9 27527.4 27623.7 55921.2 56572.0 57217.4 57219.0 57441.7 574061.0 577036.0 577596.0 577805.0 578383.0 19891.7 26853.9 27213.0 27669.2 27850.6 43584.6 44458.8 44564.3 45346.8 45741.5 37706.8 38654.6 38721.8 40008.0 40619.8 37758.2 37878.8 37944.6 38820.4 38894.6 38764.4 38810.0 39720.8 40636.2 40687.2 27232.5 30382.5 33647.7 33917.8 34396.7 22197.9 23601.2 25281.0 25683.5 25808.9 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34437.84 Median:26946.03 stddev:100571.02 (373.2%) stddev-sans-first:100820.67 09:03:52 INFO - PROCESS | 1665 | Values: 396.6 396.8 397.7 400.5 408.9 19296.0 19914.0 20260.5 20285.4 20418.6 19815.6 20704.8 20935.9 21516.5 21541.0 5783.6 5867.7 6119.4 6128.7 6131.1 5585.6 5945.2 6026.1 6052.1 6055.0 5916.4 5922.1 5947.9 5951.5 5953.4 5945.7 5962.3 6058.4 6571.4 6572.8 5851.6 5862.9 5869.4 5884.9 5892.7 15937.7 21478.6 25752.0 26943.7 26948.3 2081.6 2107.6 2133.5 2273.4 2752.9 9602.2 9812.4 10094.3 10699.5 15285.0 1685.6 1775.5 1776.8 1797.6 1808.6 85364.0 89484.0 120030.0 127340.0 128099.4 8129.6 10571.9 11399.5 11634.4 11752.8 15145.3 15228.0 15243.1 15271.6 15285.3 7599.2 7999.6 8014.8 8033.7 8372.4 7225.3 7679.4 7947.1 8012.2 8114.4 4492.4 4554.1 4561.4 4609.7 4641.9 1907.2 1976.9 1980.5 1981.3 1982.3 865.4 936.9 965.8 1006.0 1037.6 20297.6 20701.7 20805.5 21018.7 21032.6 953.7 964.5 991.1 997.1 1016.8 10821.7 10991.0 11011.5 11033.7 11066.7 595426.0 596407.0 606042.0 613959.0 614018.7 93366.0 115822.0 122101.8 126384.0 130850.0 988.9 1012.1 1023.4 1030.2 1032.4 16191.7 17652.6 18125.3 18540.6 19003.7 43064.1 44389.7 51449.0 52049.2 52295.7 74692.6 75400.0 76262.0 76869.2 76920.5 7678.7 8089.2 8099.6 8368.5 8472.0 9147.7 11808.6 12434.6 12655.6 12925.2 10904.8 10908.8 10967.2 11010.5 11231.3 10635.1 10865.5 10963.3 11244.5 11269.9 9691.7 11052.8 11141.6 11212.0 11467.1 6731.3 7960.2 8338.3 8367.9 8486.7 8841.0 10794.8 10959.5 10994.9 11247.9 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5632.66 Median:4912.17 stddev:3162.05 (64.4%) stddev-sans-first:3155.09 09:03:52 INFO - PROCESS | 1665 | Values: 1422.1 1595.5 1599.7 1877.6 2002.2 7888.6 8545.2 8757.3 8758.2 8772.3 8410.7 8638.9 8644.9 8649.2 8650.1 1920.7 2141.2 2380.4 2423.4 2453.4 2067.5 2422.2 2444.7 2461.6 2464.2 2409.1 2421.0 2465.5 2466.6 2469.1 2141.7 2390.1 2433.5 2471.9 2474.8 2459.2 2468.0 2489.5 2489.7 2492.1 8553.8 8695.9 8696.9 8707.0 8708.8 5182.4 5356.1 5366.7 5372.4 5378.1 2898.2 3497.6 3544.2 3544.5 3549.0 1001.3 1017.0 1020.3 1026.1 1026.6 11513.5 11528.0 11533.1 11535.4 11540.1 3831.9 4178.5 4681.3 4721.5 4885.4 9791.5 9929.9 9942.4 9950.8 9961.0 5385.5 5400.1 5406.4 5430.8 5440.2 4260.6 4412.6 4507.6 4578.7 4579.0 3327.9 3424.2 3974.8 4108.0 4112.3 1295.4 1320.9 1321.5 1338.4 1342.5 908.2 926.3 927.2 938.5 969.5 4925.9 5639.9 5843.4 5935.0 6031.0 438.1 446.3 451.1 462.2 465.8 3894.2 3993.9 4055.1 4068.5 4069.3 10030.0 10516.1 10776.5 10908.5 10924.0 10476.6 10477.3 10500.5 10503.3 10608.0 7430.7 7578.6 7865.6 7915.9 8151.9 5812.8 5958.9 5965.3 5977.2 6033.0 9775.6 9855.8 9883.2 9961.4 9967.2 8383.3 10053.4 10079.6 10111.2 10215.4 6912.8 7131.8 7158.2 7178.4 7301.9 7763.8 8113.8 8358.3 8368.2 8377.1 7176.0 7350.2 7429.6 7443.5 7507.3 7169.4 7241.5 7247.9 7366.5 7401.1 6947.8 7003.8 7015.2 7016.5 7031.0 4817.5 4898.4 4966.8 5033.3 5163.6 4928.4 4945.5 5068.4 5089.9 5300.9 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4933.08 Median:5548.04 stddev:1574.84 (28.4%) stddev-sans-first:1539.94 09:03:52 INFO - PROCESS | 1665 | Values: 273.7 308.4 318.6 326.5 328.7 4883.6 5705.1 5827.4 5852.3 5866.5 4500.6 5211.3 5580.7 5667.2 5807.9 3960.8 4134.3 4323.7 4392.6 4399.1 4390.3 4403.5 4404.4 4409.8 4427.4 3140.8 3790.9 4255.4 4290.4 4298.8 3485.3 3696.7 4248.0 4261.1 4284.5 3669.0 3673.8 3683.9 3684.8 3699.1 4815.0 5220.3 5283.3 5510.0 5515.4 4890.9 4911.5 4947.8 4960.8 4983.8 6028.4 6046.6 6061.5 6079.9 6088.5 3890.4 4049.4 4053.1 4077.1 4078.9 5487.3 6217.9 6349.7 6425.4 6431.8 3934.3 4010.8 4127.8 4129.7 4134.7 3487.4 3869.0 4027.1 4197.1 4197.2 4181.0 4864.7 4886.5 4895.9 4928.7 5495.8 5709.9 6104.9 6122.6 6133.9 1308.9 1383.0 1435.8 1436.0 1457.1 878.0 942.4 966.9 968.3 970.2 4737.7 5650.2 5727.8 5739.0 5745.9 5298.8 6039.8 6426.6 6435.1 6452.8 5766.4 5772.9 5808.9 5831.3 5831.4 2861.8 3348.9 3405.5 3410.2 3425.4 5216.0 6525.7 6617.4 6776.3 6783.4 6560.4 6570.5 6666.2 6693.4 6697.9 5788.9 5831.9 5885.4 6482.4 6798.1 5421.0 5618.7 6296.2 6463.7 6470.7 6040.9 6343.1 6354.0 6367.7 6367.9 5489.3 6642.6 6796.7 6814.2 6842.2 3531.4 4181.6 4214.7 4218.6 4241.7 4969.5 5780.2 6166.3 6444.0 6476.2 5296.5 5662.9 5857.8 6227.4 6247.6 5855.5 5966.6 6206.1 6233.8 6255.9 5108.7 5372.6 5949.9 6073.2 6144.9 5473.0 5988.7 6252.2 6272.2 6279.5 5042.5 6117.4 6139.1 6145.5 6163.9 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:17568.23 Median:585.57 stddev:24533.93 (4189.7%) stddev-sans-first:24569.88 09:03:52 INFO - PROCESS | 1665 | Values: 654.6 674.8 722.3 729.0 730.5 14678.0 14691.3 15071.6 15131.4 15387.1 13889.2 14045.4 14087.3 14094.9 14139.2 597.3 621.5 729.3 747.9 930.9 905.7 945.9 947.3 948.9 949.2 951.2 993.3 993.7 995.4 1000.6 762.4 961.7 983.5 987.6 988.0 724.1 730.4 733.0 733.5 734.2 14987.3 15109.3 15113.6 15123.5 15126.8 10403.5 12368.6 12684.7 12745.5 12951.0 8571.9 9945.9 9949.1 10145.9 10146.9 3456.2 3489.4 3493.0 3542.8 3554.5 78670.0 79054.6 79290.2 79999.0 81951.6 9562.4 9704.6 9739.7 9940.8 10095.0 18489.0 22328.4 22399.9 22403.3 22431.2 7197.4 7286.4 7310.5 7421.4 7479.6 3953.3 4011.9 4022.9 4023.2 4026.1 3539.3 3651.2 3656.4 3658.9 3669.1 609.2 625.7 640.0 644.3 645.4 558.2 565.7 571.7 584.6 610.7 7777.7 7969.3 8062.3 8095.4 8250.2 536.8 581.9 582.8 586.5 636.6 3280.8 3301.5 3372.2 3785.5 4014.8 88243.0 90223.5 91035.0 91523.5 92020.0 77511.6 77930.0 78140.6 78261.6 78301.0 66364.7 68028.3 68872.3 69875.0 70180.3 7712.2 7727.3 7818.9 7854.0 7899.1 31598.7 38486.0 41265.0 43132.4 45025.8 47358.8 47823.5 56686.0 58149.0 65427.7 11148.6 11394.6 11778.0 11825.9 12454.9 11922.2 12101.3 12282.9 12316.4 12367.8 11355.9 11453.4 11526.8 11805.0 12024.4 11158.5 11185.6 11355.1 11433.4 11729.9 11374.5 11435.6 11835.5 11869.3 11950.8 9421.6 9592.9 9663.6 9928.7 10244.6 9657.2 9704.2 9735.6 9802.9 9879.9 09:03:52 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:03:52 INFO - PROCESS | 1665 | 09:03:52 INFO - TEST-INFO | 1665: exit 0 09:03:52 INFO - TEST-OK | dromaeo_css | took 1115591ms 09:03:52 INFO - TEST-START | kraken 09:03:52 INFO - operating with platform_type : mac_ 09:03:52 INFO - Initialising browser for kraken test... 09:03:52 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpfkAydc/profile http://localhost:49278/getInfo.html) 09:03:55 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 09:03:55 INFO - PROCESS | 1674 | colorDepth:24 09:03:55 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 09:03:55 INFO - PROCESS | 1674 | __metrics 09:03:55 INFO - PROCESS | 1674 | 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:03:55 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:03:56 INFO - TEST-INFO | 1674: exit 0 09:03:56 INFO - Browser initialized. 09:03:56 INFO - Running cycle 1/1 for kraken test... 09:03:56 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpfkAydc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:08 INFO - PROCESS | 1676 | RSS: Main: 239067136 09:04:08 INFO - PROCESS | 1676 | 09:04:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:11 INFO - PROCESS | 1676 | RSS: Main: 286105600 09:04:11 INFO - PROCESS | 1676 | 09:04:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 09:04:15 INFO - PROCESS | 1676 | RSS: Main: 299274240 09:04:15 INFO - PROCESS | 1676 | 09:04:18 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 09:04:19 INFO - PROCESS | 1676 | RSS: Main: 383643648 09:04:19 INFO - PROCESS | 1676 | 09:04:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 09:04:22 INFO - PROCESS | 1676 | RSS: Main: 285675520 09:04:22 INFO - PROCESS | 1676 | 09:04:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:24 INFO - PROCESS | 1676 | RSS: Main: 290910208 09:04:24 INFO - PROCESS | 1676 | 09:04:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:28 INFO - PROCESS | 1676 | RSS: Main: 328634368 09:04:28 INFO - PROCESS | 1676 | 09:04:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:31 INFO - PROCESS | 1676 | RSS: Main: 330334208 09:04:31 INFO - PROCESS | 1676 | 09:04:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 09:04:35 INFO - PROCESS | 1676 | RSS: Main: 326864896 09:04:35 INFO - PROCESS | 1676 | 09:04:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:37 INFO - PROCESS | 1676 | RSS: Main: 319913984 09:04:37 INFO - PROCESS | 1676 | 09:04:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:39 INFO - PROCESS | 1676 | RSS: Main: 327393280 09:04:39 INFO - PROCESS | 1676 | 09:04:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:42 INFO - PROCESS | 1676 | RSS: Main: 329707520 09:04:42 INFO - PROCESS | 1676 | 09:04:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:46 INFO - PROCESS | 1676 | RSS: Main: 334897152 09:04:46 INFO - PROCESS | 1676 | 09:04:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:49 INFO - PROCESS | 1676 | RSS: Main: 332427264 09:04:49 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 09:04:51 INFO - PROCESS | 1676 | RSS: Main: 398024704 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | __start_tp_report 09:04:51 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 09:04:51 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 09:04:51 INFO - PROCESS | 1676 | |i|pagename|runs| 09:04:51 INFO - PROCESS | 1676 | |0;ai-astar;112;111;111;110;112;111;116;111;112;112 09:04:51 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;122;147;188;120;133;161;145;215;120 09:04:51 INFO - PROCESS | 1676 | |2;audio-dft;185;185;211;242;200;182;251;211;184;186 09:04:51 INFO - PROCESS | 1676 | |3;audio-fft;82;72;88;91;56;58;58;79;98;82 09:04:51 INFO - PROCESS | 1676 | |4;audio-oscillator;89;91;139;100;115;122;131;79;76;131 09:04:51 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;87;85;87;85;87;84;88;85;87;83 09:04:51 INFO - PROCESS | 1676 | |6;imaging-darkroom;92;93;93;93;92;92;93;93;97;92 09:04:51 INFO - PROCESS | 1676 | |7;imaging-desaturate;84;85;86;84;85;90;84;85;83;86 09:04:51 INFO - PROCESS | 1676 | |8;json-parse-financial;56;59;57;58;58;57;58;74;59;56 09:04:51 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;64;67;72;70;70;69;66;68;67;67 09:04:51 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;82;81;82;82;83;80;80;81;83;82 09:04:51 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;141;140;159;153;149;150;136;136;167;139 09:04:51 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;173;167;167;188;166;170;172;169;168;167 09:04:51 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;67;69;67;72;70;68;69;67;70 09:04:51 INFO - PROCESS | 1676 | __end_tp_report 09:04:51 INFO - PROCESS | 1676 | __start_cc_report 09:04:51 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1934 09:04:51 INFO - PROCESS | 1676 | __end_cc_report 09:04:51 INFO - PROCESS | 1676 | __startTimestamp1461254691468__endTimestamp 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | ------- Summary: start ------- 09:04:51 INFO - PROCESS | 1676 | Number of tests: 14 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.62 (1.4%) stddev-sans-first:1.72 09:04:51 INFO - PROCESS | 1676 | Values: 112.0 111.0 111.0 110.0 112.0 111.0 116.0 111.0 112.0 112.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:151.50 stddev:31.14 (20.6%) stddev-sans-first:32.97 09:04:51 INFO - PROCESS | 1676 | Values: 156.0 122.0 147.0 188.0 120.0 133.0 161.0 145.0 215.0 120.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:203.70 Median:205.50 stddev:25.16 (12.2%) stddev-sans-first:25.76 09:04:51 INFO - PROCESS | 1676 | Values: 185.0 185.0 211.0 242.0 200.0 182.0 251.0 211.0 184.0 186.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:76.40 Median:82.00 stddev:14.89 (18.2%) stddev-sans-first:15.66 09:04:51 INFO - PROCESS | 1676 | Values: 82.0 72.0 88.0 91.0 56.0 58.0 58.0 79.0 98.0 82.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:107.50 stddev:23.19 (21.6%) stddev-sans-first:23.63 09:04:51 INFO - PROCESS | 1676 | Values: 89.0 91.0 139.0 100.0 115.0 122.0 131.0 79.0 76.0 131.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.62 (1.9%) stddev-sans-first:1.66 09:04:51 INFO - PROCESS | 1676 | Values: 87.0 85.0 87.0 85.0 87.0 84.0 88.0 85.0 87.0 83.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:1.49 (1.6%) stddev-sans-first:1.54 09:04:51 INFO - PROCESS | 1676 | Values: 92.0 93.0 93.0 93.0 92.0 92.0 93.0 93.0 97.0 92.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.93 (2.3%) stddev-sans-first:2.00 09:04:51 INFO - PROCESS | 1676 | Values: 84.0 85.0 86.0 84.0 85.0 90.0 84.0 85.0 83.0 86.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:5.31 (9.2%) stddev-sans-first:5.50 09:04:51 INFO - PROCESS | 1676 | Values: 56.0 59.0 57.0 58.0 58.0 57.0 58.0 74.0 59.0 56.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.50 stddev:2.31 (3.4%) stddev-sans-first:1.94 09:04:51 INFO - PROCESS | 1676 | Values: 64.0 67.0 72.0 70.0 70.0 69.0 66.0 68.0 67.0 67.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 09:04:51 INFO - PROCESS | 1676 | Values: 82.0 81.0 82.0 82.0 83.0 80.0 80.0 81.0 83.0 82.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:149.50 stddev:10.46 (7.0%) stddev-sans-first:10.86 09:04:51 INFO - PROCESS | 1676 | Values: 141.0 140.0 159.0 153.0 149.0 150.0 136.0 136.0 167.0 139.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:169.50 stddev:6.50 (3.8%) stddev-sans-first:6.84 09:04:51 INFO - PROCESS | 1676 | Values: 173.0 167.0 167.0 188.0 166.0 170.0 172.0 169.0 168.0 167.0 09:04:51 INFO - PROCESS | 1676 | 09:04:51 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.72 09:04:51 INFO - PROCESS | 1676 | Values: 69.0 67.0 69.0 67.0 72.0 70.0 68.0 69.0 67.0 70.0 09:04:51 INFO - PROCESS | 1676 | -------- Summary: end -------- 09:04:51 INFO - PROCESS | 1676 | 09:04:52 INFO - TEST-INFO | 1676: exit 0 09:04:52 INFO - TEST-OK | kraken | took 59504ms 09:04:52 INFO - SUITE-END | took 1175s 09:04:52 INFO - Completed test suite (00:19:35) 09:04:52 INFO - javascript benchmark 09:04:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.488576713493, 3470.600880898696, 3498.1254686328416, 3502.5446691930047, 3535.6464353564647, 5695.117256825193, 5695.288088988877, 5700.486956173943, 5730.05454100073, 5755.1942728018, 5736.053551164053, 5751.223584816049, 5851.941480585193, 5887.941120588793, 5890.116482527612, 5131.820386286481, 5175.016746818102, 5203.661761985478, 5214.400343960455, 5272.762725677354, 5254.080535906221, 5309.5752339812725, 5326.014687282865, 5334.466553344654, 5382.1926710993275, 4288.206681763883, 5145.922811157836, 5155.922661160085, 5231.973840130775, 5278.076336641092, 5197.7920883164625, 5238.0, 5240.659357141773, 5251.159814429673, 5259.737013149365, 5170.405403378622, 5177.404598471148, 5203.739813009334, 5208.583313334924, 5229.2156176573435, 5592.552595792326, 5689.630174038674, 5702.116171993348, 5709.800156994527, 5710.600257981943, 6179.969100154515, 6260.812175634738, 6289.088082228097, 6293.527985401113, 6299.149614801989, 6227.408396202353, 6287.056941458772, 6308.2745484269435, 6313.558050936436, 6315.305316415191, 5658.207850900877, 5769.249997500298, 5793.8551536211935, 5798.159266906275, 5798.768049278024, 6288.088227207121, 6335.493160547145, 6361.395667411589, 6363.681815909186, 6365.458935990493, 6155.35368786271, 6166.4758495527485, 6178.165947597106, 6182.258129024546, 6229.875402491924, 6124.258880972529, 6205.782797602063, 6215.96892015537, 6305.716242769086, 6307.653079080603, 6215.378462153839, 6245.937540624535, 6250.531210159256, 6253.624782513064, 6274.6548939808745, 4894.461609222983, 6233.781817636361, 6270.059491076284, 6275.905861412082, 6277.309495955441, 4825.686330388514, 4909.140900342426, 4913.70517768935, 4928.186849169919, 4945.109880221595, 4355.346697995326, 4394.384786129945, 4401.427814384174, 4404.0, 4420.138073075719, 4926.581240594518, 5294.073537130987, 5516.586256030814, 5528.972355138279, 5543.944560554423, 5758.280214973129, 6119.929102025404, 6183.783567575113, 6302.243730752339, 6307.211598550181, 5666.575006874418, 5668.688222147822, 5673.659580425187, 5696.8006119785605, 5713.143028545752, 5399.676019438846, 5411.053065713484, 5411.83764487066, 5412.945870541244, 5417.512423881791, 5387.461253874581, 6252.656103914237, 6303.401176888188, 6428.325025872216, 6432.678366081771, 6262.15460912771, 6269.153664255267, 6282.0, 6287.74849006053, 6288.0882272069375, 6245.812625621239, 6354.936450635434, 6357.745690172342, 6389.073584330153, 6391.488680905423, 6124.594542075297, 6169.290531588746, 6233.0, 6239.438450539473, 6243.500519958483, 5046.571041461517, 5291.656042357235, 6206.224221972254, 6263.4362907338555, 6266.373362663697, 5154.845354639367, 5163.612729045261, 6006.639601623917, 6130.601510901777, 6163.784267550794, 6136.592867771182, 6140.03518873956, 6141.271221159771, 6143.0, 6150.261968563801, 5961.225040744675, 5996.730147143477, 5998.610090344114, 6009.278886533644, 6024.0662697282, 5822.126680997884, 5899.616524925866, 5910.970445147746, 6151.815445536641, 6159.84600384994, 5974.790882319272, 5980.0, 5996.400359964143, 6013.849653758691, 6033.879322413615], "value": 5674.241739897596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.9792408303667, 529.8357509172155, 588.6497533967289, 589.6727316339435, 619.108483783352, 24481.510369792595, 31231.0, 31240.21899452512, 31259.374812503764, 39299.803500982525, 42946.570534294726, 43752.343714844304, 43760.562394376044, 43783.34324985128, 43837.78081109598, 9466.38468499547, 9698.9515052425, 9701.223902087817, 9709.660161894335, 9711.660091896785, 8753.0, 9013.098690131, 9025.007249202616, 9726.319157658967, 9877.0, 8841.425307355034, 8923.553822308892, 9788.510574471284, 11670.0, 11916.10629202809, 11564.768704625902, 11697.473613687362, 11698.005669518016, 11705.473253703603, 11732.824007639892, 8697.304215662733, 9732.0, 11511.136664750176, 11680.883191168065, 11684.357360345177, 41776.0, 42628.57371426277, 42642.57357426417, 42714.0, 42805.14389712188, 3259.6903294187014, 3376.3922493951077, 3405.625381208065, 3528.576570811493, 3563.0914116900285, 28924.27689307763, 29212.70787292121, 29461.852690736625, 29880.40239195204, 29888.0, 2724.4278701472713, 2728.3042824079735, 2743.396452780385, 2779.3051737065734, 2822.985885070582, 398426.0, 399633.0, 400322.0, 400696.0, 401964.0, 35970.92087237387, 36828.0, 36898.63101369006, 36904.89285321391, 62204.75590488256, 36317.636823631954, 36453.81773091118, 36543.269134617156, 36553.08617284536, 36590.8170459146, 14298.356573954197, 14484.275786210857, 14500.927495362455, 14537.854621453862, 14542.272886355851, 12193.573224937085, 12242.632721018384, 12263.325517096646, 12280.508779648713, 12594.87405125937, 7721.189275126143, 7933.444658873939, 8304.460210086447, 8358.498490090615, 8422.578871056423, 3373.241020770307, 3468.236987862666, 3471.531343268626, 3471.7743346682387, 3503.964960350415, 848.1221935297061, 918.609590923868, 952.5094576293214, 954.1841725324886, 990.9900900990898, 29146.7085329144, 29640.664680357313, 29683.554746678816, 29883.530445900295, 30040.399192016474, 1136.477220478589, 1154.878737732526, 1183.2131632464486, 1217.9025677945742, 1249.4564864284066, 15754.975926564737, 15836.970596911164, 15849.969751966086, 15956.0, 16238.431654892021, 630354.0, 642297.0, 642776.0, 642804.0, 642997.0, 52365.7381713089, 63400.682996585645, 64293.35706642967, 64314.0, 64392.67803660952, 1467.9779803302958, 1505.0668585477074, 1514.719776841266, 1516.7876497290388, 1517.582664767198, 26764.330891727084, 26992.190234293004, 27195.86402068056, 27527.449451011267, 27623.72376276292, 55921.16118258148, 56572.0, 57217.427825721206, 57219.0, 57441.71279143745, 574061.0, 577036.0, 577596.0, 577805.0, 578383.0, 19891.701624475932, 26853.865730671223, 27213.0, 27669.16992490148, 27850.582241266802, 43584.56415435805, 44458.777706111265, 44564.331535027646, 45346.773266134776, 45741.542584573726, 37706.8114659425, 38654.61345386622, 38721.80639096787, 40008.0, 40619.7969010153, 37758.244835102596, 37878.8106059468, 37944.62055379521, 38820.41769373405, 38894.6110538891, 38764.41853372145, 38810.02974925649, 39720.801395992836, 40636.1872762549, 40687.1862562753, 27232.455350893266, 30382.54426183653, 33647.663523364456, 33917.8128765492, 34396.65603343934, 22197.889010554845, 23601.168118523838, 25281.0, 25683.486330273663, 25808.870955645103], "value": 18583.94974090434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.5934916710372, 396.82143035633965, 397.6838413461298, 400.51737656124357, 408.92843752343333, 19296.0, 19914.0, 20260.493487662814, 20285.39143825686, 20418.59162816743, 19815.603687926232, 20704.792952070475, 20935.895320523377, 21516.462088447795, 21541.0, 5783.5951483396175, 5867.735951882154, 6119.418655227746, 6128.724207410677, 6131.110988906606, 5585.609007369486, 5945.16767652529, 6026.126211699301, 6052.122442245872, 6055.0, 5916.408359164092, 5922.141289513018, 5947.910781338283, 5951.494122999528, 5953.3748956359605, 5945.702714864261, 5962.314333851597, 6058.363871793486, 6571.408573228432, 6572.835679108012, 5851.64890106595, 5862.941370586283, 5869.413058694139, 5884.941150588482, 5892.675902825343, 15937.681246375008, 21478.57042859134, 25751.96992120313, 26943.73056269432, 26948.326291842666, 2081.5940891526157, 2107.6311645462138, 2133.4879628888957, 2273.3975496493445, 2752.926358720101, 9602.183814375787, 9812.411255324632, 10094.29339946204, 10699.518521666543, 15285.0, 1685.6207353345521, 1775.520609435458, 1776.786785585738, 1797.5595978985102, 1808.6292310076403, 85364.0, 89484.0, 120030.0, 127340.0, 128099.35950320282, 8129.593520323961, 10571.894281057092, 11399.48702308398, 11634.418279086012, 11752.76494470123, 15145.318460669296, 15228.0, 15243.08541487492, 15271.618209544627, 15285.312160952784, 7599.202083781234, 7999.600119963988, 8014.759557213293, 8033.718819841394, 8372.358024259467, 7225.349718525358, 7679.424043196783, 7947.086085100287, 8012.238837310446, 8114.350851931831, 4492.3935268738305, 4554.0891821635805, 4561.407017087824, 4609.700369475973, 4641.86074417768, 1907.2085084689697, 1976.9209231630862, 1980.5048737815546, 1981.2570286142698, 1982.3359174676646, 865.4201684871151, 936.8782058332373, 965.8454647256406, 1006.0191313469309, 1037.5642230263309, 20297.594048118954, 20701.68947465789, 20805.479863003242, 21018.684719729215, 21032.579348412946, 953.666216824106, 964.4647220792527, 991.0634450444261, 997.0876647867266, 1016.8220561401725, 10821.729456763644, 10991.0, 11011.504482298316, 11033.668989930315, 11066.723331916766, 595426.0, 596407.0, 606042.0, 613959.0228684038, 614018.7196256139, 93366.0, 115822.0, 122101.77898220904, 126384.0, 130850.0, 988.8961659025842, 1012.0790081026231, 1023.3757407980977, 1030.2273295028729, 1032.3599368391644, 16191.676166476369, 17652.558686032437, 18125.27498900082, 18540.629187416445, 19003.71494427557, 43064.13871722611, 44389.66830995075, 51449.0, 52049.21926171035, 52295.73852130715, 74692.62653686697, 75400.0, 76262.0, 76869.23130768845, 76920.46159076899, 7678.721111244198, 8089.2315230053055, 8099.595020249082, 8368.45605035695, 8471.95764021176, 9147.725568232963, 11808.586699465477, 12434.56479023266, 12655.557055503014, 12925.15986460877, 10904.836427453753, 10908.78401858691, 10967.232293739362, 11010.528730816664, 11231.326120432801, 10635.096016838655, 10865.456727163768, 10963.287386319864, 11244.493997769956, 11269.943650282024, 9691.70924872255, 11052.778944420907, 11141.554337826396, 11212.046976006804, 11467.139964502529, 6731.259561448334, 7960.164182760726, 8338.332933365438, 8367.916320836714, 8486.70296539643, 8841.0, 10794.784104317712, 10959.506822192861, 10994.890051099386, 11247.943760281147], "value": 9489.53986140154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.0969684250497, 1595.5452695981644, 1599.6720672262184, 1877.6244751049785, 2002.2391491233338, 7888.605569721512, 8545.23092921637, 8757.25563327118, 8758.211760941505, 8772.254358379529, 8410.663573457054, 8638.913610863889, 8644.913550864489, 8649.221570058693, 8650.134986501347, 1920.7310976463307, 2141.1863491873146, 2380.3929997850523, 2423.4183795889035, 2453.4479742058074, 2067.4727944374163, 2422.2248880358293, 2444.69441319835, 2461.6184491403774, 2464.2484042367073, 2409.084547871806, 2420.9636855447184, 2465.5315490056832, 2466.5560199164142, 2469.086438017936, 2141.68945502902, 2390.127603424755, 2433.5254625348066, 2471.938201544958, 2474.8391354562077, 2459.1515927005153, 2468.0, 2489.5394352044927, 2489.676342075537, 2492.0779311654624, 8553.786155346104, 8695.869561956575, 8696.913030869737, 8707.0, 8708.825823483558, 5182.4299327073995, 5356.062689029443, 5366.731663416814, 5372.382176049765, 5378.139497680391, 2898.1740204041957, 3497.6327485613897, 3544.1848374873666, 3544.4860495228304, 3549.0, 1001.3441196016548, 1016.9644062457852, 1020.336781092296, 1026.0662796854826, 1026.5637104230748, 11513.539458421654, 11527.962483376536, 11533.077353811675, 11535.423228838525, 11540.134489913291, 3831.9233615328094, 4178.456800615962, 4681.250999840009, 4721.504242054603, 4885.438174609965, 9791.510424478747, 9929.900700993043, 9942.353747006422, 9950.751231219132, 9961.0, 5385.461453854661, 5400.135978243462, 5406.351237851483, 5430.755615997289, 5440.238366628675, 4260.6378457830815, 4412.646988240933, 4507.639388848885, 4578.6794924355645, 4578.9771051144535, 3327.866885324608, 3424.1610805352348, 3974.813852381179, 4108.014076621649, 4112.300908845504, 1295.430010795247, 1320.8877245434053, 1321.4780161836213, 1338.3910320804011, 1342.4697244588333, 908.232543500754, 926.3145272498438, 927.2396634759567, 938.5072836760619, 969.5491596407704, 4925.901481970341, 5639.887202255932, 5843.357230704619, 5934.970325148433, 6031.0, 438.0887753472769, 446.2703479810533, 451.09780439121755, 462.1888585532436, 465.77177183180675, 3894.1627550076305, 3993.880183594497, 4055.1484188320783, 4068.4710987571425, 4069.328560787496, 10030.047145521165, 10516.053555179917, 10776.515056822462, 10908.50911708975, 10924.0, 10476.63331783384, 10477.266591338534, 10500.474976251156, 10503.264771466076, 10608.0, 7430.736774748306, 7578.621068946641, 7865.567393793282, 7915.881261781078, 8151.8777218341775, 5812.796552120655, 5958.880822383441, 5965.308976228096, 5977.163197152315, 6033.0045542484995, 9775.608975640895, 9855.802883942137, 9883.159931405911, 9961.35251208669, 9967.202623789934, 8383.329333653171, 10053.447060411747, 10079.596816127272, 10111.24165687591, 10215.38707677512, 6912.758053468105, 7131.82170445743, 7158.212596614264, 7178.353948144692, 7301.926980730337, 7763.805904852198, 8113.797155071171, 8358.289545388467, 8368.24685778283, 8377.120402357908, 7175.964120179575, 7350.154732205651, 7429.591372474566, 7443.516171448839, 7507.286807753255, 7169.426445884213, 7241.45689073311, 7247.927520724726, 7366.484346095722, 7401.1488678802625, 6947.756828510978, 7003.7548685795755, 7015.158181018311, 7016.473764467583, 7031.0, 4817.494163112823, 4898.436679781728, 4966.751662416792, 5033.345665063518, 5163.612729045261, 4928.408590969107, 4945.455999839943, 5068.417132029864, 5089.931114466003, 5300.946990530046], "value": 4470.281347042994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.6674939947963, 308.39708370136384, 318.59538386249466, 326.53631842783244, 328.7123766704134, 4883.6337274704365, 5705.087186050222, 5827.4463925927075, 5852.297724273088, 5866.530677545797, 4500.5724456176695, 5211.348581427322, 5580.693061881595, 5667.206591077253, 5807.912881306784, 3960.7919584526708, 4134.276501612221, 4323.675724320673, 4392.582704643054, 4399.120175964804, 4390.297552391618, 4403.537628549005, 4404.4054052702795, 4409.757463339515, 4427.409965170379, 3140.7801453898237, 3790.886273411802, 4255.425492567754, 4290.377895205193, 4298.78506074695, 3485.3203625293204, 3696.6672999430048, 4248.022954720432, 4261.105167914741, 4284.507281662618, 3668.981655091734, 3673.81630918453, 3683.889483315505, 3684.7604905681046, 3699.130704284491, 4815.036992601459, 5220.269162317279, 5283.260343551906, 5509.972450137724, 5515.393306736256, 4890.926636100461, 4911.50884911506, 4947.826826061107, 4960.826371076995, 4983.825566105205, 6028.427299406593, 6046.576739628228, 6061.454469097758, 6079.90561698894, 6088.512918966472, 3890.3580909149955, 4049.3521036633997, 4053.1285773558825, 4077.1234184650443, 4078.9184216315803, 5487.286652735119, 6217.880781459336, 6349.714262858136, 6425.389587989133, 6431.839204019937, 3934.311495488278, 4010.7593544386846, 4127.8422007164545, 4129.69027322952, 4134.710570260053, 3487.372272990886, 3868.9806550967064, 4027.1448385178965, 4197.139586384784, 4197.18154959786, 4181.0, 4864.70811751289, 4886.486918873538, 4895.853124406273, 4928.704277743347, 5495.763453223073, 5709.914351284734, 6104.908426373608, 6122.632642041492, 6133.907991380132, 1308.9149205301815, 1382.9930850345684, 1435.8133442652597, 1435.956921292363, 1457.0820383158543, 877.9517126558101, 942.359195746885, 966.9274804389698, 968.25444407807, 970.2383628851318, 4737.739424331695, 5650.208970744099, 5727.77088916447, 5738.99567575681, 5745.931464672714, 5298.81454149103, 6039.761848820981, 6426.550141490051, 6435.106760409884, 6452.806415807533, 5766.4233576642, 5772.884542309214, 5808.941910580925, 5831.329397119385, 5831.4168583141345, 2861.8139820911574, 3348.8827891024184, 3405.506201600754, 3410.23269764306, 3425.4071856586806, 5216.0, 6525.694861027719, 6617.437517810944, 6776.2546119926765, 6783.423409010191, 6560.442362399154, 6570.507211959122, 6666.233383160901, 6693.397594216543, 6697.866042679119, 5788.9290481261105, 5831.941680583224, 5885.439833672366, 6482.416582507597, 6798.125068710886, 5420.972895135499, 5618.718404699569, 6296.198191804786, 6463.676816159267, 6470.708818103102, 6040.946078333388, 6343.11196432509, 6354.015127655221, 6367.745290188341, 6367.936320636734, 5489.313835770528, 6642.634655094016, 6796.66016699173, 6814.182298124257, 6842.213145488333, 3531.3643544162296, 4181.623653871045, 4214.662826973896, 4218.55705150967, 4241.724287921399, 4969.503049695146, 5780.219670344618, 6166.290876549254, 6443.96778016107, 6476.222853257639, 5296.470352964673, 5662.915056274242, 5857.765689372377, 6227.439530442282, 6247.562670613013, 5855.531557475307, 5966.582339236212, 6206.10011548332, 6233.844153896189, 6255.937440625536, 5108.66793658411, 5372.62391632582, 5949.881002380015, 6073.180120683651, 6144.907826382519, 5473.01485732556, 5988.6706231157705, 6252.218472690914, 6272.247330320209, 6279.510150242599, 5042.495750424928, 6117.418845209698, 6139.140520327069, 6145.508359331154, 6163.9383606163365], "value": 4425.9692638809975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5679851298144, 674.7773234832506, 722.3174100475053, 729.0340299103689, 730.4886579394425, 14678.0, 14691.265436728148, 15071.62320941977, 15131.394744210233, 15387.076775393483, 13889.236092014935, 14045.438182472715, 14087.29563521825, 14094.859051409483, 14139.222342771143, 597.3011576455557, 621.546271222006, 729.2634439216403, 747.8766003609398, 930.9022552631977, 905.6920646980026, 945.9337846350758, 947.2800671489683, 948.928830337724, 949.2074118111351, 951.2485136741966, 993.2897977945768, 993.746594618375, 995.3579940938091, 1000.6447711062577, 762.3786613909646, 961.6634178037701, 983.4640121133999, 987.6493844685177, 987.9753006174831, 724.1346590823968, 730.393773168269, 732.9670164842595, 733.4609062339176, 734.2327268004948, 14987.32557034936, 15109.320080596399, 15113.622159445991, 15123.546293611209, 15126.848731512655, 10403.479437875765, 12368.567100151451, 12684.746305073846, 12745.490180392773, 12951.028672849574, 8571.89840491534, 9945.850812237823, 9949.115363380008, 10145.898541014569, 10146.898531014669, 3456.1705190754037, 3489.354469423165, 3493.0, 3542.822858857073, 3554.537910071674, 78670.0, 79054.60472697657, 79290.20709792885, 79999.0, 81951.5902420496, 9562.378445401027, 9704.563294651758, 9739.707808765748, 9940.80118397628, 10095.0, 18489.0, 22328.441788955406, 22399.88800055989, 22403.32790016302, 22431.21490747816, 7197.388222001188, 7286.417086633057, 7310.4517161213125, 7421.443391745533, 7479.588622625699, 3953.347697629859, 4011.859584914572, 4022.8591999279884, 4023.155137421116, 4026.074002979331, 3539.2744487380023, 3651.1784848409425, 3656.3601369760186, 3658.8902332929524, 3669.082729317671, 609.1776102261999, 625.7403177681211, 639.9936000640027, 644.3395519592361, 645.4158986117477, 558.198984457297, 565.6973519167308, 571.6598623818821, 584.6024703201779, 610.703808652803, 7777.72777952769, 7969.282764551218, 8062.269398025858, 8095.3523718102415, 8250.174982501821, 536.7906516458585, 581.9476247137778, 582.8193260089386, 586.5395664403422, 636.6084857812505, 3280.7867488613165, 3301.5377847101427, 3372.2412457197424, 3785.466920827588, 4014.759114453142, 88243.0, 90223.54888225517, 91035.0, 91523.54238228766, 92020.0, 77511.61244193742, 77930.0, 78140.6092969543, 78261.60869195731, 78301.0, 66364.6681766588, 68028.31971680319, 68872.31127688759, 69874.9518757219, 70180.2981970184, 7712.1516633169185, 7727.265909738566, 7818.85213232359, 7853.958188843843, 7899.0521137463875, 31598.684013159575, 38486.0, 41265.0, 43132.353014704175, 45025.77487112543, 47358.76320618375, 47823.52176478191, 56686.0, 58149.0, 65427.710030148715, 11148.609798657008, 11394.601188958346, 11777.998870095795, 11825.93566579012, 12454.875451245372, 11922.225055371373, 12101.273923564615, 12282.877171228174, 12316.384180791103, 12367.814482782585, 11355.886441135814, 11453.370064646191, 11526.769464610494, 11805.0, 12024.398780060787, 11158.497867595815, 11185.552577897119, 11355.091592672401, 11433.371164586028, 11729.941350293195, 11374.54501819918, 11435.59975400857, 11835.526578936746, 11869.287842729464, 11950.760984780429, 9421.623135074795, 9592.856107158537, 9663.565139568876, 9928.652497162564, 10244.590216391261, 9657.170928253603, 9704.175145112744, 9735.561899714672, 9802.852957205505, 9879.851802222829], "value": 6780.283600141489, "unit": "score"}], "name": "dromaeo_css", "value": 7155.728043852456, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 110.0, 112.0, 111.0, 116.0, 111.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 147.0, 188.0, 120.0, 133.0, 161.0, 145.0, 215.0, 120.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 211.0, 242.0, 200.0, 182.0, 251.0, 211.0, 184.0, 186.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 88.0, 91.0, 56.0, 58.0, 58.0, 79.0, 98.0, 82.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 139.0, 100.0, 115.0, 122.0, 131.0, 79.0, 76.0, 131.0], "value": 107.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 84.0, 88.0, 85.0, 87.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 97.0, 92.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 84.0, 85.0, 90.0, 84.0, 85.0, 83.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0, 74.0, 59.0, 56.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 72.0, 70.0, 70.0, 69.0, 66.0, 68.0, 67.0, 67.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 82.0, 83.0, 80.0, 80.0, 81.0, 83.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 159.0, 153.0, 149.0, 150.0, 136.0, 136.0, 167.0, 139.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 167.0, 188.0, 166.0, 170.0, 172.0, 169.0, 168.0, 167.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 67.0, 72.0, 70.0, 68.0, 69.0, 67.0, 70.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1509.1999999999998, "alertThreshold": 2.0}]} 09:04:52 INFO - Return code: 0 09:04:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:04:52 ERROR - # TBPL SUCCESS # 09:04:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:04:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:04:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:04:52 INFO - 2016-04-21 09:04:52.762 screenresolution[1680:9770] starting screenresolution argv=screenresolution get 09:04:52 INFO - 2016-04-21 09:04:52.765 screenresolution[1680:9770] Display 0: 1600x1200x32@60 09:04:52 INFO - 2016-04-21 09:04:52.771 screenresolution[1681:9773] starting screenresolution argv=screenresolution list 09:04:52 INFO - Available Modes on Display 0 09:04:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:04:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:04:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:04:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:04:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:04:53 INFO - Intel Iris: 09:04:53 INFO - Chipset Model: Intel Iris 09:04:53 INFO - Type: GPU 09:04:53 INFO - Bus: Built-In 09:04:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:04:53 INFO - Vendor: Intel (0x8086) 09:04:53 INFO - Device ID: 0x0a2e 09:04:53 INFO - Revision ID: 0x0009 09:04:53 INFO - Displays: 09:04:53 INFO - Display: 09:04:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:04:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:04:53 INFO - Display Serial Number: 1600x1200 60 09:04:53 INFO - Main Display: Yes 09:04:53 INFO - Mirror: Off 09:04:53 INFO - Online: Yes 09:04:53 INFO - Rotation: Supported 09:04:53 INFO - Return code: 0 09:04:53 INFO - Running post-action listener: _resource_record_post_action 09:04:53 INFO - Running post-run listener: _resource_record_post_run 09:04:54 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37516800; Write bytes: 693753856; Read time: 427; Write time: 2068 09:04:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384115200; Write bytes: 377882624; Read time: 28336; Write time: 691 09:04:54 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35726848; Write bytes: 296091648; Read time: 408; Write time: 1334 09:04:54 INFO - Running post-run listener: _upload_blobber_files 09:04:54 INFO - Blob upload gear active. 09:04:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:54 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:04:54 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:04:54 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:04:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:55 INFO - (blobuploader) - INFO - Done attempting. 09:04:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:56 INFO - (blobuploader) - INFO - Done attempting. 09:04:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:56 INFO - Return code: 0 09:04:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9236a75430605491020ddd46681e3dd46c0088ab55b7bb968500a7ec3faf90debe8bae8550346177c97649ceb02a7ab3e6fc30d05f54efbf39cbc736ade298c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd2e0bce09fde3d765bd07660d1ad170c44ea40ba40aad3963d480291c0bca7646434f736e7f6c872db6f75373aba1dd5068038edf55b0565e3bd05ff7b2d2e4"} 09:04:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:56 INFO - Contents: 09:04:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9236a75430605491020ddd46681e3dd46c0088ab55b7bb968500a7ec3faf90debe8bae8550346177c97649ceb02a7ab3e6fc30d05f54efbf39cbc736ade298c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd2e0bce09fde3d765bd07660d1ad170c44ea40ba40aad3963d480291c0bca7646434f736e7f6c872db6f75373aba1dd5068038edf55b0565e3bd05ff7b2d2e4"} 09:04:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:56 INFO - Copying logs to upload dir... 09:04:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.428287 ========= master_lag: 7.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-21 09:05:03.597127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 09:05:03.601004) ========= 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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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/c9236a75430605491020ddd46681e3dd46c0088ab55b7bb968500a7ec3faf90debe8bae8550346177c97649ceb02a7ab3e6fc30d05f54efbf39cbc736ade298c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd2e0bce09fde3d765bd07660d1ad170c44ea40ba40aad3963d480291c0bca7646434f736e7f6c872db6f75373aba1dd5068038edf55b0565e3bd05ff7b2d2e4"} build_url:https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011926 build_url: 'https://queue.taskcluster.net/v1/task/UHJwo8C6SmarfTypZMASGw/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/c9236a75430605491020ddd46681e3dd46c0088ab55b7bb968500a7ec3faf90debe8bae8550346177c97649ceb02a7ab3e6fc30d05f54efbf39cbc736ade298c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd2e0bce09fde3d765bd07660d1ad170c44ea40ba40aad3963d480291c0bca7646434f736e7f6c872db6f75373aba1dd5068038edf55b0565e3bd05ff7b2d2e4"}' ========= master_lag: 0.92 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 09:05:04.535198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 mins, 20 secs) (at 2016-04-21 09:05:04.535492) ========= 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.uKdIQ3rlx2/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.0c4Nxm76eO/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005193 ========= master_lag: 140.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 mins, 20 secs) (at 2016-04-21 09:07:24.861689) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-21 09:07:24.861982) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-21 09:07:28.908319) ========= ========= Total master_lag: 148.35 =========