builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0058 starttime: 1461943168.24 results: success (0) buildid: 20160429063004 builduid: 23f900474d4e4b66937eca49b23be124 revision: 0af3c129a3665692271cda977178286d5937e326 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:28.239785) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:28.240199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-29 08:19:28.240470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-29 08:19:29.250911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:29.251257) ========= 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.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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-29 08:19:29-- 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% 71.5M=0s 2016-04-29 08:19:29 (71.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145222 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:29.554555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:29.554867) ========= 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.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.026847 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:29.622786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 08:19:29.623125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0af3c129a3665692271cda977178286d5937e326 --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 0af3c129a3665692271cda977178286d5937e326 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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-29 08:19:29,705 truncating revision to first 12 chars 2016-04-29 08:19:29,705 Setting DEBUG logging. 2016-04-29 08:19:29,705 attempt 1/10 2016-04-29 08:19:29,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0af3c129a366?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 08:19:31,536 unpacking tar archive at: fx-team-0af3c129a366/testing/mozharness/ program finished with exit code 0 elapsedTime=2.079311 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-29 08:19:31.751593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:31.754884) ========= script_repo_revision: 0af3c129a3665692271cda977178286d5937e326 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:31.755293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:31.755558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:19:31.778960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-29 08:19:31.779310) ========= /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.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:19:31 INFO - MultiFileLogger online at 20160429 08:19:31 in /builds/slave/test 08:19:31 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:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:19:31 INFO - {'append_to_log': False, 08:19:31 INFO - 'base_work_dir': '/builds/slave/test', 08:19:31 INFO - 'blob_upload_branch': 'Fx-Team', 08:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:19:31 INFO - 'branch': 'Fx-Team', 08:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:31 INFO - 'config_files': ('talos/mac_config.py',), 08:19:31 INFO - 'default_actions': ('clobber', 08:19:31 INFO - 'read-buildbot-config', 08:19:31 INFO - 'download-and-extract', 08:19:31 INFO - 'populate-webroot', 08:19:31 INFO - 'create-virtualenv', 08:19:31 INFO - 'install', 08:19:31 INFO - 'run-tests'), 08:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:31 INFO - 'download_minidump_stackwalk': True, 08:19:31 INFO - 'download_symbols': 'ondemand', 08:19:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:31 INFO - 'installer_path': 'installer.exe', 08:19:31 INFO - 'log_level': 'info', 08:19:31 INFO - 'log_name': 'talos', 08:19:31 INFO - 'log_to_console': True, 08:19:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:19:31 INFO - 'opt_config_files': (), 08:19:31 INFO - 'pip_index': False, 08:19:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:31 INFO - 'cmd': ('bash', 08:19:31 INFO - '-c', 08:19:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:31 INFO - 'enabled': True, 08:19:31 INFO - 'halt_on_failure': False, 08:19:31 INFO - 'name': 'check_screen_resolution'},), 08:19:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:31 INFO - 'cmd': ('bash', 08:19:31 INFO - '-c', 08:19:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:31 INFO - 'enabled': True, 08:19:31 INFO - 'halt_on_failure': False, 08:19:31 INFO - 'name': 'check_screen_resolution'},), 08:19:31 INFO - 'run_cmd_checks_enabled': True, 08:19:31 INFO - 'sps_profile': False, 08:19:31 INFO - 'sps_profile_interval': 0, 08:19:31 INFO - 'suite': 'dromaeojs', 08:19:31 INFO - 'system_bits': '32', 08:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:31 INFO - 'title': 't-yosemite-r7-0058', 08:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:31 INFO - 'use_talos_json': True, 08:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:31 INFO - 'work_dir': 'build'} 08:19:31 INFO - ##### 08:19:31 INFO - ##### Running clobber step. 08:19:31 INFO - ##### 08:19:31 INFO - Running pre-action listener: _resource_record_pre_action 08:19:31 INFO - Running main action method: clobber 08:19:31 INFO - rmtree: /builds/slave/test/build 08:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:19:33 INFO - Running post-action listener: _resource_record_post_action 08:19:33 INFO - ##### 08:19:33 INFO - ##### Running read-buildbot-config step. 08:19:33 INFO - ##### 08:19:33 INFO - Running pre-action listener: _resource_record_pre_action 08:19:33 INFO - Running main action method: read_buildbot_config 08:19:33 INFO - Using buildbot properties: 08:19:33 INFO - { 08:19:33 INFO - "project": "", 08:19:33 INFO - "product": "firefox", 08:19:33 INFO - "script_repo_revision": "production", 08:19:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:19:33 INFO - "repository": "", 08:19:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:19:33 INFO - "buildid": "20160429063004", 08:19:33 INFO - "pgo_build": "False", 08:19:33 INFO - "basedir": "/builds/slave/test", 08:19:33 INFO - "buildnumber": 677, 08:19:33 INFO - "slavename": "t-yosemite-r7-0058", 08:19:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:19:33 INFO - "platform": "yosemite_r7", 08:19:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:19:33 INFO - "branch": "fx-team", 08:19:33 INFO - "repo_path": "integration/fx-team", 08:19:33 INFO - "revision": "0af3c129a3665692271cda977178286d5937e326", 08:19:33 INFO - "stage_platform": "macosx64", 08:19:33 INFO - "builduid": "23f900474d4e4b66937eca49b23be124", 08:19:33 INFO - "slavebuilddir": "test" 08:19:33 INFO - } 08:19:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 08:19:33 INFO - Running post-action listener: _resource_record_post_action 08:19:33 INFO - ##### 08:19:33 INFO - ##### Running download-and-extract step. 08:19:33 INFO - ##### 08:19:33 INFO - Running pre-action listener: _resource_record_pre_action 08:19:33 INFO - Running main action method: download_and_extract 08:19:33 INFO - mkdir: /builds/slave/test/build/tests 08:19: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:19:33 INFO - https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 08:19:41 INFO - Downloaded 1199 bytes. 08:19:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:19:41 INFO - Using the following test package requirements: 08:19:41 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:19:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 08:19:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 08:19:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'jsshell-mac.zip'], 08:19:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 08:19:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:19:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 08:19:41 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 08:19:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 08:19:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:19:41 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 08:19:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:41 INFO - https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:19:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:19:43 INFO - Downloaded 18124385 bytes. 08:19:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:19:46 INFO - Return code: 0 08:19:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:19:46 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:19:46 INFO - https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:19:52 INFO - Downloaded 18124385 bytes. 08:19:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:19:55 INFO - Return code: 0 08:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:55 INFO - https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:19:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:19:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:19:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:19:56 INFO - Downloaded 10840145 bytes. 08:19:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:19:57 INFO - Return code: 0 08:19: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:19:57 INFO - https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 08:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 08:20:00 INFO - Downloaded 110282516 bytes. 08:20:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:20:00 INFO - mkdir: /builds/slave/test/properties 08:20:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:00 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:00 INFO - Contents: 08:20:00 INFO - build_url:https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:20:01 INFO - Running post-action listener: _resource_record_post_action 08:20:01 INFO - Running post-action listener: set_extra_try_arguments 08:20:01 INFO - ##### 08:20:01 INFO - ##### Running populate-webroot step. 08:20:01 INFO - ##### 08:20:01 INFO - Running pre-action listener: _resource_record_pre_action 08:20:01 INFO - Running main action method: populate_webroot 08:20:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:01 INFO - '--tppagecycles', 08:20:01 INFO - '7'], 08:20:01 INFO - 'tests': ['tsvgm']}}, 08:20:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['damp', 'tps']}, 08:20:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'tests': ['damp', 'tps']}, 08:20:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['dromaeo_dom']}, 08:20:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['a11yr', 08:20:01 INFO - 'ts_paint', 08:20:01 INFO - 'tpaint', 08:20:01 INFO - 'sessionrestore', 08:20:01 INFO - 'sessionrestore_no_auto_restore', 08:20:01 INFO - 'tabpaint']}, 08:20:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['tsvgx', 08:20:01 INFO - 'tsvgr_opacity', 08:20:01 INFO - 'tart', 08:20:01 INFO - 'tscrollx', 08:20:01 INFO - 'cart']}, 08:20:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:01 INFO - 'tsvgr_opacity', 08:20:01 INFO - 'tart', 08:20:01 INFO - 'tscrollx', 08:20:01 INFO - 'cart']}, 08:20:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'talos_options': ['--disable-e10s'], 08:20:01 INFO - 'tests': ['tp5o']}, 08:20:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'tests': ['tp5o']}, 08:20:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'talos_options': ['--disable-e10s', 08:20:01 INFO - '--xperf_path', 08:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:01 INFO - 'tests': ['tp5n']}, 08:20:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:01 INFO - 'talos_options': ['--xperf_path', 08:20:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:01 INFO - 'tests': ['tp5n']}}, 08:20:01 INFO - 'talos.zip': {'path': '', 08:20:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:01 INFO - Running post-action listener: _resource_record_post_action 08:20:01 INFO - ##### 08:20:01 INFO - ##### Running create-virtualenv step. 08:20:01 INFO - ##### 08:20:01 INFO - Running pre-action listener: _resource_record_pre_action 08:20:01 INFO - Running main action method: create_virtualenv 08:20:01 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:01 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:20:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:01 INFO - Using real prefix '/tools/python27' 08:20:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:02 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:05 INFO - Installing pip.................done. 08:20:05 INFO - Return code: 0 08:20:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:05 INFO - 'HOME': '/Users/cltbld', 08:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:05 INFO - 'LOGNAME': 'cltbld', 08:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:05 INFO - 'MOZ_NO_REMOTE': '1', 08:20:05 INFO - 'NO_EM_RESTART': '1', 08:20:05 INFO - 'PAGER': '/bin/cat', 08:20:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:05 INFO - 'PWD': '/builds/slave/test', 08:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:05 INFO - 'SHELL': '/bin/bash', 08:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:05 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:05 INFO - 'USER': 'cltbld', 08:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:05 INFO - 'XPC_FLAGS': '0x0', 08:20:05 INFO - 'XPC_SERVICE_NAME': '0', 08:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:05 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:20:05 INFO - Cleaning up... 08:20:05 INFO - Return code: 0 08:20:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:05 INFO - 'HOME': '/Users/cltbld', 08:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:05 INFO - 'LOGNAME': 'cltbld', 08:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:05 INFO - 'MOZ_NO_REMOTE': '1', 08:20:05 INFO - 'NO_EM_RESTART': '1', 08:20:05 INFO - 'PAGER': '/bin/cat', 08:20:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:05 INFO - 'PWD': '/builds/slave/test', 08:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:05 INFO - 'SHELL': '/bin/bash', 08:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:05 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:05 INFO - 'USER': 'cltbld', 08:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:05 INFO - 'XPC_FLAGS': '0x0', 08:20:05 INFO - 'XPC_SERVICE_NAME': '0', 08:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:05 INFO - Downloading/unpacking psutil>=0.7.1 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:08 INFO - Installing collected packages: psutil 08:20:08 INFO - Running setup.py install for psutil 08:20:09 INFO - building 'psutil._psutil_osx' extension 08:20:09 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:20:09 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:20:09 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:20:09 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:20:09 INFO - building 'psutil._psutil_posix' extension 08:20:09 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:20:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:09 INFO - ^ 08:20:10 INFO - 1 warning generated. 08:20:10 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:20:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:10 INFO - Successfully installed psutil 08:20:10 INFO - Cleaning up... 08:20:10 INFO - Return code: 0 08:20:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:20:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:10 INFO - 'HOME': '/Users/cltbld', 08:20:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:10 INFO - 'LOGNAME': 'cltbld', 08:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:10 INFO - 'MOZ_NO_REMOTE': '1', 08:20:10 INFO - 'NO_EM_RESTART': '1', 08:20:10 INFO - 'PAGER': '/bin/cat', 08:20:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:10 INFO - 'PWD': '/builds/slave/test', 08:20:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:10 INFO - 'SHELL': '/bin/bash', 08:20:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:10 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:10 INFO - 'USER': 'cltbld', 08:20:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:10 INFO - 'XPC_FLAGS': '0x0', 08:20:10 INFO - 'XPC_SERVICE_NAME': '0', 08:20:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:12 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:20:12 INFO - Installing collected packages: mozsystemmonitor 08:20:12 INFO - Running setup.py install for mozsystemmonitor 08:20:13 INFO - Successfully installed mozsystemmonitor 08:20:13 INFO - Cleaning up... 08:20:13 INFO - Return code: 0 08:20:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:13 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:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:13 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:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:13 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:13 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:20:13 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:20:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:13 INFO - 'HOME': '/Users/cltbld', 08:20:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:13 INFO - 'LOGNAME': 'cltbld', 08:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:13 INFO - 'MOZ_NO_REMOTE': '1', 08:20:13 INFO - 'NO_EM_RESTART': '1', 08:20:13 INFO - 'PAGER': '/bin/cat', 08:20:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:13 INFO - 'PWD': '/builds/slave/test', 08:20:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:13 INFO - 'SHELL': '/bin/bash', 08:20:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:13 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:13 INFO - 'USER': 'cltbld', 08:20:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:13 INFO - 'XPC_FLAGS': '0x0', 08:20:13 INFO - 'XPC_SERVICE_NAME': '0', 08:20:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:15 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:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20: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:20: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:20: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:20: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:20: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:20: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:20:16 INFO - Downloading docopt-0.6.1.tar.gz 08:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:17 INFO - Running setup.py install for blobuploader 08:20:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:17 INFO - Running setup.py install for requests 08:20:17 INFO - Running setup.py install for docopt 08:20:17 INFO - Successfully installed blobuploader requests docopt 08:20:17 INFO - Cleaning up... 08:20:17 INFO - Return code: 0 08:20:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:17 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:17 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:20:17 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:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:17 INFO - 'HOME': '/Users/cltbld', 08:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:17 INFO - 'LOGNAME': 'cltbld', 08:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:17 INFO - 'MOZ_NO_REMOTE': '1', 08:20:17 INFO - 'NO_EM_RESTART': '1', 08:20:17 INFO - 'PAGER': '/bin/cat', 08:20:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:17 INFO - 'PWD': '/builds/slave/test', 08:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:17 INFO - 'SHELL': '/bin/bash', 08:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:17 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:17 INFO - 'USER': 'cltbld', 08:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:17 INFO - 'XPC_FLAGS': '0x0', 08:20:17 INFO - 'XPC_SERVICE_NAME': '0', 08:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-qwtW_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-3JSMDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-PBfWHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-OPsjnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Fc6M82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Wlq70Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-47DVzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-nwvpHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-XUeH8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wLx26V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-FvPUsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-rjEIy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-G72yJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-sXTwOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-IF3JID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-GVqd8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-agH2cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:20 INFO - Running setup.py install for manifestparser 08:20:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Running setup.py install for mozcrash 08:20:20 INFO - Running setup.py install for mozdebug 08:20:20 INFO - Running setup.py install for mozdevice 08:20:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Running setup.py install for mozfile 08:20:20 INFO - Running setup.py install for mozhttpd 08:20:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:20 INFO - Running setup.py install for mozinfo 08:20:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozInstall 08:20:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozleak 08:20:21 INFO - Running setup.py install for mozlog 08:20:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for moznetwork 08:20:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozprocess 08:20:21 INFO - Running setup.py install for mozprofile 08:20:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:21 INFO - Running setup.py install for mozrunner 08:20:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Running setup.py install for mozscreenshot 08:20:22 INFO - Running setup.py install for moztest 08:20:22 INFO - Running setup.py install for mozversion 08:20:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:22 INFO - Cleaning up... 08:20:22 INFO - Return code: 0 08:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:22 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:22 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:20:22 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:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:22 INFO - 'HOME': '/Users/cltbld', 08:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:22 INFO - 'LOGNAME': 'cltbld', 08:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:22 INFO - 'MOZ_NO_REMOTE': '1', 08:20:22 INFO - 'NO_EM_RESTART': '1', 08:20:22 INFO - 'PAGER': '/bin/cat', 08:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:22 INFO - 'PWD': '/builds/slave/test', 08:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:22 INFO - 'SHELL': '/bin/bash', 08:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:22 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:22 INFO - 'USER': 'cltbld', 08:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:22 INFO - 'XPC_FLAGS': '0x0', 08:20:22 INFO - 'XPC_SERVICE_NAME': '0', 08:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:22 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-sTJ3Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-314n0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-ta5dyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-r8rTXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-X2dwUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-q1z0YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-GIF6Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-LfXatU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-oIdwrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-5XI7SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:23 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wRObLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-sjSnE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-NYsZ_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-D5UWta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-rkIOiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-A_pVkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:24 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:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:24 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-WjDCOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 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:20:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:27 INFO - Downloading blessings-1.6.tar.gz 08:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:27 INFO - Installing collected packages: blessings 08:20:27 INFO - Running setup.py install for blessings 08:20:27 INFO - Successfully installed blessings 08:20:27 INFO - Cleaning up... 08:20:27 INFO - Return code: 0 08:20:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:27 INFO - Reading from file tmpfile_stdout 08:20:27 INFO - Current package versions: 08:20:27 INFO - blessings == 1.6 08:20:27 INFO - blobuploader == 1.2.4 08:20:27 INFO - docopt == 0.6.1 08:20:27 INFO - manifestparser == 1.1 08:20:27 INFO - mozInstall == 1.12 08:20:27 INFO - mozcrash == 0.17 08:20:27 INFO - mozdebug == 0.1 08:20:27 INFO - mozdevice == 0.48 08:20:27 INFO - mozfile == 1.2 08:20:27 INFO - mozhttpd == 0.7 08:20:27 INFO - mozinfo == 0.9 08:20:27 INFO - mozleak == 0.1 08:20:27 INFO - mozlog == 3.1 08:20:27 INFO - moznetwork == 0.27 08:20:27 INFO - mozprocess == 0.22 08:20:27 INFO - mozprofile == 0.28 08:20:27 INFO - mozrunner == 6.11 08:20:27 INFO - mozscreenshot == 0.1 08:20:27 INFO - mozsystemmonitor == 0.0 08:20:27 INFO - moztest == 0.7 08:20:27 INFO - mozversion == 1.4 08:20:27 INFO - psutil == 3.1.1 08:20:27 INFO - requests == 1.2.3 08:20:27 INFO - wsgiref == 0.1.2 08:20:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:27 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:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:27 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:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:27 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:27 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:20:27 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:20:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:27 INFO - 'HOME': '/Users/cltbld', 08:20:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:27 INFO - 'LOGNAME': 'cltbld', 08:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:27 INFO - 'MOZ_NO_REMOTE': '1', 08:20:27 INFO - 'NO_EM_RESTART': '1', 08:20:27 INFO - 'PAGER': '/bin/cat', 08:20:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:27 INFO - 'PWD': '/builds/slave/test', 08:20:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:27 INFO - 'SHELL': '/bin/bash', 08:20:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:27 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:27 INFO - 'USER': 'cltbld', 08:20:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:27 INFO - 'XPC_FLAGS': '0x0', 08:20:27 INFO - 'XPC_SERVICE_NAME': '0', 08:20:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 INFO - Cleaning up... 08:20:28 INFO - Return code: 0 08:20:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:20: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:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:28 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:28 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:20:28 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:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:28 INFO - 'HOME': '/Users/cltbld', 08:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:28 INFO - 'LOGNAME': 'cltbld', 08:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:28 INFO - 'MOZ_NO_REMOTE': '1', 08:20:28 INFO - 'NO_EM_RESTART': '1', 08:20:28 INFO - 'PAGER': '/bin/cat', 08:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:28 INFO - 'PWD': '/builds/slave/test', 08:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:28 INFO - 'SHELL': '/bin/bash', 08:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:28 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:28 INFO - 'USER': 'cltbld', 08:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:28 INFO - 'XPC_FLAGS': '0x0', 08:20:28 INFO - 'XPC_SERVICE_NAME': '0', 08:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:28 INFO - Downloading/unpacking jsonschema 08:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:28 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:20:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:30 INFO - Downloading/unpacking functools32 (from jsonschema) 08:20: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:20: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:20: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:20: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:20: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:20: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:20:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:31 INFO - warning: no files found matching '*.txt' 08:20:31 INFO - no previously-included directories found matching 'build' 08:20:31 INFO - no previously-included directories found matching 'dist' 08:20:31 INFO - no previously-included directories found matching '.git*' 08:20:31 INFO - Installing collected packages: jsonschema, functools32 08:20:31 INFO - Running setup.py install for functools32 08:20:31 INFO - warning: no files found matching '*.txt' 08:20:31 INFO - no previously-included directories found matching 'build' 08:20:31 INFO - no previously-included directories found matching 'dist' 08:20:31 INFO - no previously-included directories found matching '.git*' 08:20:31 INFO - Successfully installed jsonschema functools32 08:20:31 INFO - Cleaning up... 08:20:31 INFO - Return code: 0 08:20:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 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 0x109d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff21b5a7320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, '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.daYNdjVjzR/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.5l8jlMBCJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:20:31 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:20:31 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:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:31 INFO - 'HOME': '/Users/cltbld', 08:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:31 INFO - 'LOGNAME': 'cltbld', 08:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:31 INFO - 'MOZ_NO_REMOTE': '1', 08:20:31 INFO - 'NO_EM_RESTART': '1', 08:20:31 INFO - 'PAGER': '/bin/cat', 08:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:31 INFO - 'PWD': '/builds/slave/test', 08:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:31 INFO - 'SHELL': '/bin/bash', 08:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:20:31 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:31 INFO - 'USER': 'cltbld', 08:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:31 INFO - 'XPC_FLAGS': '0x0', 08:20:31 INFO - 'XPC_SERVICE_NAME': '0', 08:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:31 INFO - Downloading/unpacking flake8 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:20:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:20:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:20:35 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:20:35 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:20:35 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:20:35 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:20:35 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:20:35 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:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:20:35 INFO - no previously-included directories found matching 'docs/_build' 08:20:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:20:35 INFO - Running setup.py install for pep8 08:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:20:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:20:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:20:35 INFO - no previously-included directories found matching 'docs/_build' 08:20:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:20:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:20:35 INFO - Cleaning up... 08:20:35 INFO - Return code: 0 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - Running post-action listener: _start_resource_monitoring 08:20:35 INFO - Starting resource monitoring. 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running install step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: install 08:20:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:36 INFO - Reading from file tmpfile_stdout 08:20:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:20:36 INFO - Reading from file tmpfile_stdout 08:20:36 INFO - Output received: 08:20:36 INFO - Usage: mozinstall [options] installer 08:20:36 INFO - Options: 08:20:36 INFO - -h, --help show this help message and exit 08:20:36 INFO - -d DEST, --destination=DEST 08:20:36 INFO - Directory to install application into. [default: 08:20:36 INFO - "/builds/slave/test"] 08:20:36 INFO - --app=APP Application being installed. [default: firefox] 08:20:36 INFO - mkdir: /builds/slave/test/build/application 08:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:21:10 INFO - Reading from file tmpfile_stdout 08:21:10 INFO - Output received: 08:21:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:21:10 INFO - Running post-action listener: _resource_record_post_action 08:21:10 INFO - ##### 08:21:10 INFO - ##### Running run-tests step. 08:21:10 INFO - ##### 08:21:10 INFO - Running pre-action listener: _resource_record_pre_action 08:21:10 INFO - Running main action method: run_tests 08:21:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:10 INFO - 2016-04-29 08:21:10.383 screenresolution[1652:8246] starting screenresolution argv=screenresolution get 08:21:10 INFO - 2016-04-29 08:21:10.385 screenresolution[1652:8246] Display 0: 1600x1200x32@60 08:21:10 INFO - 2016-04-29 08:21:10.391 screenresolution[1653:8248] starting screenresolution argv=screenresolution list 08:21:10 INFO - Available Modes on Display 0 08:21:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:10 INFO - Intel Iris: 08:21:10 INFO - Chipset Model: Intel Iris 08:21:10 INFO - Type: GPU 08:21:10 INFO - Bus: Built-In 08:21:10 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:10 INFO - Vendor: Intel (0x8086) 08:21:10 INFO - Device ID: 0x0a2e 08:21:10 INFO - Revision ID: 0x0009 08:21:10 INFO - Displays: 08:21:10 INFO - Display: 08:21:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:10 INFO - Display Serial Number: 1600x1200 60 08:21:10 INFO - Main Display: Yes 08:21:10 INFO - Mirror: Off 08:21:10 INFO - Online: Yes 08:21:10 INFO - Rotation: Supported 08:21:10 INFO - Return code: 0 08:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:10 INFO - Python 2.7.3 08:21:10 INFO - Return code: 0 08:21:10 INFO - grabbing minidump binary from tooltool 08:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:10 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 0x109c20e00>, '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 0x109a49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c1bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:10 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:21:10 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:21:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:10 INFO - Return code: 0 08:21:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:21:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:21:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:21:11 INFO - Return code: 0 08:21:11 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/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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:21:11 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/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0058 --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:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daYNdjVjzR/Render', 08:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:11 INFO - 'HOME': '/Users/cltbld', 08:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:11 INFO - 'LOGNAME': 'cltbld', 08:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:11 INFO - 'MOZ_NO_REMOTE': '1', 08:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:11 INFO - 'NO_EM_RESTART': '1', 08:21:11 INFO - 'PAGER': '/bin/cat', 08:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:11 INFO - 'PWD': '/builds/slave/test', 08:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:11 INFO - 'SHELL': '/bin/bash', 08:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5l8jlMBCJO/Listeners', 08:21:11 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 08:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:11 INFO - 'USER': 'cltbld', 08:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:11 INFO - 'XPC_FLAGS': '0x0', 08:21:11 INFO - 'XPC_SERVICE_NAME': '0', 08:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:11 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/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0058', '--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:21:12 INFO - mozversion application_buildid: 20160429063004 08:21:12 INFO - mozversion application_changeset: 0af3c129a3665692271cda977178286d5937e326 08:21:12 INFO - mozversion application_display_name: Nightly 08:21:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:12 INFO - mozversion application_name: Firefox 08:21:12 INFO - mozversion application_remotingname: firefox 08:21:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:21:12 INFO - mozversion application_vendor: Mozilla 08:21:12 INFO - mozversion application_version: 49.0a1 08:21:12 INFO - mozversion platform_buildid: 20160429063004 08:21:12 INFO - mozversion platform_changeset: 0af3c129a3665692271cda977178286d5937e326 08:21:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:21:12 INFO - mozversion platform_version: 49.0a1 08:21:12 INFO - using testdate: 1461943272 08:21:12 INFO - actual date: 1461943272 08:21:12 INFO - starting webserver on 'localhost:49275' 08:21:12 INFO - SUITE-START | Running 2 tests 08:21:12 INFO - TEST-START | dromaeo_css 08:21:12 INFO - operating with platform_type : mac_ 08:21:12 INFO - Initialising browser for dromaeo_css test... 08:21:12 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpHqrp5_/profile http://localhost:49275/getInfo.html) 08:21:14 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 08:21:14 INFO - PROCESS | 1671 | colorDepth:24 08:21:14 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 08:21:14 INFO - PROCESS | 1671 | __metrics 08:21:14 INFO - PROCESS | 1671 | 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:21:14 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:21:15 INFO - TEST-INFO | 1671: exit 0 08:21:15 INFO - Browser initialized. 08:21:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:15 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpHqrp5_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:27 INFO - PROCESS | 1674 | RSS: Main: 239628288 08:21:27 INFO - PROCESS | 1674 | 08:22:18 INFO - PROCESS | 1674 | 1461943338277 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:24:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:24:30 INFO - PROCESS | 1674 | RSS: Main: 368652288 08:24:30 INFO - PROCESS | 1674 | 08:27:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 08:27:34 INFO - PROCESS | 1674 | RSS: Main: 370806784 08:27:34 INFO - PROCESS | 1674 | 08:30:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 08:30:36 INFO - PROCESS | 1674 | RSS: Main: 368381952 08:30:36 INFO - PROCESS | 1674 | 08:33:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 08:33:39 INFO - PROCESS | 1674 | RSS: Main: 369238016 08:33:39 INFO - PROCESS | 1674 | 08:36:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 08:36:43 INFO - PROCESS | 1674 | RSS: Main: 339120128 08:36:43 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 08:39:46 INFO - PROCESS | 1674 | RSS: Main: 373821440 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | __start_tp_report 08:39:46 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 08:39:46 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 08:39:46 INFO - PROCESS | 1674 | |i|pagename|runs| 08:39:46 INFO - PROCESS | 1674 | |0;dojo.html;2849.3873817129315;3404.812735299559;3412.5904891413034;3442.208292092817;3467.133216695826;4793.185158523046;5551.8889622207535;5635.464630860061;5672.290963629546;5685.545156387484;5407.3781515125775;5547.11246200608;5565;5665.660060396379;5694.971525142379;5075.162598171298;5126.71803050832;5127.615428842833;5130.897382052357;5282.815101471449;5224.764885580139;5245.082110630643;5251.264822924793;5272.868178295555;5275.57795376369;5056.84829455117;5115.155999260155;5133.691978481284;5190.143626301656;5258.316418865561;5171.922421163686;5195.298634684307;5196.9740151299;5207.817726379559;5224.03355379256;5127.179651255781;5149.794008239666;5184.896302073975;5208.583313334924;5211.452797456288;5405.5135037846785;5519.972400138014;5533.833984980457;5534.916976245359;5560.582956278296;5052.671576347526;5987.520998320124;6007.15899774032;6043.576949613529;6063.646931415128;6209.410106039919;6246.344133865924;6265.686715664244;6271;6284.591501552431;5636.070048442043;5740.827775166752;5747.281589801275;5779.450952159538;5793.65238085712;6143.481172719164;6198.876022479525;6227.06594010893;6238.906416403757;6248.156498872685;6004.579679422399;6046.848828779316;6050.122732203894;6062.969685151546;6069.423404776539;6095.238095238095;6159.260888693296;6206.410391012937;6224.502039836802;6226.5641405102115;6033.245844269466;6047.5464340173785;6060.727267272983;6070.332263451017;6077.908831367533;6063.120847477091;6080.270367555921;6086.147939288503;6091.08633704939;6104.816855494342;4805.663603547788;4816.060868130751;4823.831165909176;4827.961988172559;4877.926831097537;4311.48262208537;4347.369631403429;4384.101259241847;4419.955800441954;4431.113777244564;5224.477552244821;5600.187972743929;5620.662760234399;5622.662640241599;5647.971760141173;6113.081058499921;6150.261968563801;6228.532860035515;6236.251649802053;6267.655278959701;5633.8309850704545;5644;5645.407232240637;5670.036093864053;5674.432556744293;5288.8413347599635;5305;5318.25544423781;5331.413544510178;5342.198670199501;6142.560166306883;6184.041473571604;6231.688415579112;6257.092721555349;6270.341614130451;6188.659623720739;6244.063390491463;6246.156768836331;6257.4994000480765;6262.530310226843;6230.221222347207;6250.0937364082865;6256.374362563707;6263.498920086473;6269.341719119427;5964.970175149097;6109.969450152721;6132.5707200495535;6143.296949342275;6180.969095154495;6179.81460556184;6227.564070515021;6227.844303892258;6229.190205273467;6242.563020588515;5899.764009439575;6066.3023752269055;6075.301340345917;6077.24034495688;6119.326874043941;5919.260092488439;5972.9701351494705;5989.371116032754;6030.125631783455;6090.390960903874;5835.912461313169;5836.474717275466;5840.766369345349;5854.970725146347;5880;6054.152418661479;6076.392360763888;6085.026395776655;6089.850084553785;6121.571489995657;5800.6809625471005;5898.616589921641;5907.320658124198;5997.250343707036;6016.548758843017 08:39:46 INFO - PROCESS | 1674 | |1;ext.html;500.33955179163496;535.9575625408581;576.495566379418;592.7777083593652;595.1103100864209;30336;30953.535696964536;30970.53544196839;31020.224494387596;31127.84436077822;39971.60028399722;41184;41184.38223426651;41227.175456490855;41300.380494292534;9862.30963832532;10038.598456061749;10063.849042264372;10079.496025198747;10090.142337901287;8592.828143437158;8831.293496520262;9806.901930980706;9948.25388095892;9957.800843983116;11581.36302503362;11860.288382697066;11869.643910682693;11880.405979701023;11914.702132446671;11784.882151178464;11862.288262704265;11938.403079845973;11938.985186259179;11943.223690460092;8531.57342132897;8770;8778.64885404583;8790.780230494225;11676.766464670744;37376.62623373759;38110;38110.04724881872;38152.80923595392;38215.04462388463;3241.529978153178;3254.8535315910603;3267.950980735291;3319.0872510059685;3414.0440676610588;27804.443911121663;28750.424991500262;28762.712372876424;28779.424411511653;28833.135005949644;2711.755941965213;2715.91852244433;2803.5654473556633;2818.802683812134;2873.4971380008415;486120;487681;487907;488206;488251;34172.48741268883;34822.82588587041;34827.82586087104;34932.12669683278;34950.650493495246;35588.28823423517;35984.64015359813;36061.63938360635;36151.45772813357;36194.819025904704;15423.460178893685;15623.296951637203;15630.531084067496;15634;15643.921780391025;13086.869131308566;13129;13163;13382.866171338163;13407.731845363038;7558.848823023509;7756.146823849372;8093.55485448306;8184.468009579477;8261.504309741315;3120.719135277836;3366.966330336665;3420.538227339327;3462.3421549905943;3466.930661386758;950.1970834644715;1003.9598416063276;1017.699778565325;1106.6112029403048;1178.1077454848328;30161.547576786365;30183;30266.940657077335;30313.298050445515;30412.69587304143;1096.1504833753904;1112.6439539347493;1138.869030061537;1205.5209074755257;1266.4934026389517;14218;15483.612909677347;15542.689146217012;15620.921895390678;16040.11779352147;629043;637647;638102;639243;640572;60711;63041.36958630355;63151.05273420902;63197;63210.36789632045;1325.4896864707157;1361.6459720472749;1476.9187694676896;1485.8068451101287;1545.5904185390655;29740.851295744247;30186.593363909557;30339.393212136074;30397.392052159274;30448.26501415674;50082.2487662678;52004.47995519996;52076.47923520716;52150.82793376597;52189;397330;409573;409865;410046;410488;22670.886645566665;25506;25940.481190376464;26239.606405903545;26660.06689765849;43565.12869742524;43970.680879573665;44067.644686127154;44207;44937.550624494645;30559.847200763856;31530;37488.875333740034;38879.80560097181;39085.43658253638;30243.546346805255;36652.45021324736;36902.630973691;37698.057548561505;37852.242955140195;36877.44683829798;37257.6274237265;37751.43372849355;37822.81088594539;38084.23831523409;31456.52815207728;32908;33149.502757458176;33282;33452.498212527316;24292;24348.269551913472;24506.63240051365;25089.49821003606;25172.370690732147 08:39:46 INFO - PROCESS | 1674 | |2;jquery.html;394.30798947846534;396.5954726179297;399.2175336340772;399.64232012348947;408.6036544551784;14352.497662581813;20268.986550672464;20853.791462085373;20942.790572094276;20961.47596310091;16058.75911861323;17377.73933390997;19828.60342793147;19906.303279385225;20530.076146573403;5933.970330148343;6103.755849766027;6137.693115344215;6138;6143.87712245757;5765.769369225226;6050.939490605082;6057.242844644419;6061.757529698807;6062.878367502004;5980.491658209035;6007.339192688823;6012.909806352908;6014.1580178775;6035.275766907956;5981.850453738648;6060.787872424466;6067.453929146398;6078.544109191784;6085.330613632497;5095.974520127375;5231.843044708665;5255.211718242294;5271.024860400838;5272.235525848769;25403.491930161294;25949.61075583868;25968.74031259682;26349;26868.86565567179;2361.3860396296914;2477.071098338123;2482.689663792026;2733.316670832292;2919.459899918522;14454.71090578193;14971.775423368657;15136.621584460367;15144.167070811101;15159.62100947474;1741.5123765345722;1793.8923664580168;1802.567383827885;1831.4139475367888;2036.4196204081766;110060;115161;115845.84154158435;116218;117423;11529.192956492965;11611.767764644828;11627.069834413227;11682.415879206006;12071.57749478764;14973.326200321011;15104.54686359411;15151.772723409158;15152.166630835189;15181.544553663407;7578.469507134558;7777.805554861061;8834.381385015166;8955.194032537103;9051.456912585267;8836.8674469883;8842.248408885316;8856.601452934634;8964.731058068268;8969.775755606031;4634.328022436728;4670.883227919329;4713.29300604912;4723.362346083303;4724.71651700899;1710.9572260693583;1936.7579052618423;1980.742503474539;1986.4140078676537;2027.6046170996515;927.8376284150247;952.3857112162616;976.9364991275544;984.0503913723148;1108.1688733449912;20455.386338409873;20591;21723;21805.018774154883;21919.780802192094;962.7496850818698;973.1387721866199;977.203579083045;992.6178421307849;1004.9547770350351;10270;10753.515322560597;10788.006029820854;10796.298240614493;10819.459027048617;609662;610066;611238;619019;630186;88713.55643221743;98412.68254150721;136365;137656;140454;1019.4393083804026;1115.4590023838432;1145.5017067575632;1148.7702459507964;1148.9885101149048;17939.37212197567;18081.909590451964;18144.72782908284;18224.817751822844;18513.166907489463;40267;44273;52052.69868253172;52200.47799521956;53065;72192;72795.27204727885;73600.89598656131;74257;74905.87641185278;8048.798780030546;8104.959475202822;8385.832283354177;8409.957950210455;8656.697015604424;9430.669926552811;11326.490307935997;12121.636350909486;12912.8063079052;12914.612561623166;9651.372660777028;10817.945910270399;11047.558097676003;11081.5567377304;11219.60731374398;9449.480278584744;10313.535890885078;10406.323588966692;10784.460776960963;10800.945995270287;10347.896521034694;10905.945470272598;10985.670429887115;11176.888231117584;11487.885121149016;8308.293795027248;8357.080721120794;8515.361347899056;8561.57192140378;8740.282888397494;10698.090662293793;11236.775264494829;11482.885171148182;11489.425528723697;11562.30626162433 08:39:46 INFO - PROCESS | 1674 | |3;mootools.html;1458.0886945658963;1632.3715369582708;1644.868410527158;1929.2765213045109;2038.7757346691872;7904;8712.651493940242;8939.374243802937;8942.508162051092;8942.821143577125;8555;8780.42927209731;8801.691940782073;8806.95596522018;8811.471311721301;2122.546055951674;2491.638712386703;2492.6136448850457;2492.8628925409093;2493.6384224287467;2441.182203961675;2466.8149888758326;2486.5151295497385;2487.776100150986;2489.0790407549234;2443.218170185541;2466.3710753757855;2469.876506174693;2476.1704828882257;2477.54165479386;2425.611902095674;2444.5844206484853;2456.45957889265;2460.6309053641917;2464.827462077655;2406.867622280774;2436.5979613363775;2438.829281950264;2444.841085329448;2445.730969593343;8620.956895215484;8791.516466594334;8887.733367998906;8897.199252067345;8906.153915378029;4684.227102528079;5345.663584103974;5551.805686800983;5613.410591887875;5614.101743720985;3519.788812671248;3520.436730123168;3631.7639353442205;3690.206605579813;3707.3141468828353;1007.2445665750687;1056.572088304238;1057.3550134417999;1058.772363941756;1068.3856782350101;11648.12639052066;11707.590234341757;11728.765424691459;11732.53069877204;11744.412779361082;3989.940150897739;4641.605463535638;4781.952180478151;4787.234042553175;4795.784189711471;9286.767830804283;9321.906780932239;9330.346875718635;9336.019717929656;9343.813123737487;5286.682799032071;5365.6244062916;5377.354717433933;5382.219578161144;5407.459254074561;4445.399871017371;4642.79107440166;4856.4415092264135;4941.234108713155;4973.278874563168;3451.930961380758;3843.9044872211284;3856.537215534154;3900.239453306578;3966.087799806061;1230.501646833034;1244.7261602447447;1244.8568414632434;1258.672745086284;1260.1493991555662;671.8521925176453;747.6915398053407;874.3355050161923;884.9734108890697;898.3980732908967;5488.1767734839295;5670.5747068969995;5960.523158147338;6039.1545183674325;6049.455549000523;503.52920019781624;504.2209785880823;506.94170170430135;514.1901505129437;660.8777376185421;3846.1922996171115;4013.4983127109113;4026.416169655384;4068.4100805383646;4272.829086836554;10469.581216751398;10698.78602427947;10825.350478971286;10827.621033263798;10833.729156770985;10662.73343166427;10783.406912619725;10803.13574914005;10819.83770243447;10831.783364332668;6701.765438209639;7908.52548847071;8222.506649601042;8235.38234632405;8311.293540049042;5894.528437724886;6022.849428764316;6098.329183789869;6128.509719222362;6145.4161854623735;9810.264230182907;10067.597296108366;10229.43738094412;10244.975502449695;10250.692479225636;10152.289339746147;10161.390316581028;10347.94826025865;10407.47962601882;10511.789764204826;7591.848163036819;7599.734009309647;7666.080070391588;7683.884741728767;7739.419543534144;8136.633851476579;8301.169883011651;8379.664813407395;8379.70671026511;8383.538905360263;6872.278410766798;7433.8884916727375;7571.318581327707;7635.427342949412;7745.573993430416;7214.494985350975;7368.778936631909;7400.40796736249;7483.812904677427;7551.244875512624;6927.445804335742;7091.326323999212;7092.290770922867;7100.254473280231;7114.395276401564;4856.854294371175;4891.364122664031;4892.80428782859;4947.752612369439;5160.122779127632;4423.447069116361;4960.652754307164;4984.277279794482;5064.544191022678;5281.498257665516 08:39:46 INFO - PROCESS | 1674 | |4;prototype.html;315.25599584979454;316.3388517997386;324.0553785714642;324.55211807705365;327.81478464667475;4638.837640682576;4939.629527785417;5254.553362964152;5307.70807605582;5319.521243088121;4333.414988976488;4341.674374421923;5036.8415264489095;5205.245239440288;5235.895282094356;3874.249283009067;3919.627635374635;3991.42124391963;4120.402541631462;4121.9175616487655;3312.989538190851;3822.636849499293;4085.3871919212206;4089.26393249215;4144.399062135988;3404.9489257661153;3450.6721861423125;3487.581490221164;3579.4093974494176;4048.1903619276113;3377.3788581480903;3902.64876161144;4078.5921407859273;4080.9795951020055;4102.9895351277955;3528.2414280929725;3553.8045407502577;3556.0931962349696;3564.3940530109944;3568.553930758655;5019.673721208146;5026.396832380101;5043.445221025684;5063.721495317756;5097.898042039175;4473.530279320657;4676.18166820805;4690.7654617269;4715.528447155257;4841.443234028062;5475.561955043587;5479.7944452220445;5496.477834605706;5503.3120859892515;5507.834764957058;3922.784246866421;3941.1723538057045;3942.8817135485983;3953.695280557409;3960.772160630214;4777.928331075037;5116.565091967187;5484.369297530795;5531.529819965308;5555;3522.7534072615185;3755.9248815023548;3816.904577385588;3983.3029219886403;4053.43251944728;3882.3400021996326;4097.651699605507;4097.713160078825;4099.405586189986;4108.548059713429;3932.567417584121;4421.823127074946;4475.910481790346;4660.39414876064;4685.922237885306;5085.618578606619;5446.494612478305;5524.4199359067525;5617.887642247214;5685.658860468385;1494.424646511101;1509.1020842598637;1512.160750783304;1514.48507507448;1520.5666385080199;878.9077146899612;952.2429668413628;966.6858271061792;978.5645387802502;1011.4487604255698;4981.850544483671;5380.0046991306735;5577.800772833779;5623.971880140573;5629.071203251499;5435.646682965595;6184.134221209034;6202.162708034448;6227.346128656516;6261.373862613702;5258.50044245796;5318.8936221276135;5563.721813909288;5595.580331475075;5603.2435621191435;2793.972060279412;3215.9196020099685;3251.9349613007607;3262.869485220612;3271.7709760316548;5639.689817060019;6321.209848768904;6473.352664733489;6502.44729198014;6523.967380163069;5070.7464626768515;5882.235309409835;6336.461400780985;6399.968000159969;6405.583637063576;5436.211749296409;6172.845678858064;6186.4741496973265;6403.391677790602;6509.381608747161;5223.764930578209;5702.743376547983;6178.104174894525;6192.442680158807;6208.844778880564;6074.757009719739;6102.938970610237;6110.205673262448;6119.44924956756;6120.296165940974;5154.768035438339;5392.946070539401;5433;6466.288708242184;6511.38141876521;4215.789210539399;4215.88279106031;4236.364545318227;4242;4261.019965408035;5212.374515058217;5426.833230855385;5838.978478508395;6107.6180289687945;6163.3836616338;4856.191520684438;5090.949090509195;5997.460228579449;6003.159557662018;6005.789797357072;5366.919496207638;5625.690587017753;5989.790357337472;5992.8801423972145;6013.579049466495;5140.717260550706;5297.682139071668;5346.625736198429;5883.411658834082;5893.292804863444;4941.160002799605;4986.650934434555;5251.474852514718;5565.499105080562;5588.636738611977;4831.043427411903;4868.829590964299;5238.371395432572;5445.1832225166545;5471.234027236111 08:39:46 INFO - PROCESS | 1674 | |5;yui.html;737.9409647228222;749.6589051981349;753.0361137743687;757.6628400361841;768.8039549914772;12375.257484550933;14658.340374683139;14826.258687065643;15044.924775376121;15250.6949861003;14075.859241407583;14148.575542733735;14202;14204.78692819606;14211;714.4641518860855;738.3797610007592;911.9361644684891;913.876626655403;916.8487199612056;824.5135370131621;934.5700977550301;934.7849994501269;936.7611259128912;937.4141161773891;962.4417837654179;972.4943029624591;972.951352432379;973.3186769261546;973.4791886340809;757.7007082202555;933.869258303838;964.3056998960737;967.0426277984815;977.5991843344266;724.6775185042658;724.7209824217662;725.872972229863;726.0416250549277;726.0561270348526;14627;14667.193304368255;14696.55910322692;14702.191379474125;14727.55817325482;12423.254604723656;12428.813567796491;12495.562655307112;12580.496780128784;12882;9813.558389872473;9936.105750482491;9999.900001000042;10072.395656260574;10514.631987880464;3508.5088087667746;3516.4197907345256;3517.56030496188;3583.677469027774;3590.299891521154;75947;76083;76703.23296767073;78175.60912195459;78694.21305786926;9479.194268487117;9639.518024098767;9654.469004204837;9687.58073812021;9913.65302214419;18591.90704046471;22139.225127120797;22281.10875564959;22334.776652233595;22435.439114021952;7231.023811785447;7329.853402932018;7468.439867009996;7560.054993125859;7639.083310002835;3370.443876760307;4018.9397159042055;4028.093678922219;4034.8184331705143;4036.1725846201457;3547.787132772042;3631.4915911772373;3635.0003748969243;3638.21778317663;3643.8360273787744;625.9436650701459;633.5027003801994;637.4263163153199;641;667.9532432729662;501.1532502727461;502.60294367450035;544.923710680505;596.5496050481859;616.4113271825486;8162.795930101795;8185.631646575918;8203.671853125927;8274.462159959583;8408.705695300636;491.5453205784635;586.633354153654;588.6968211371147;592.6177615438105;599.4365296621162;3768.773873567595;3853.967495219872;3897.824597893102;3935.4293627424436;4106.917861642751;92338.53830730803;93259;94715.052849472;97118.51440742752;97881;72445.46099537099;75849.62075189699;75870;76844.61577692076;79867.40265194779;66938;67440.9187035364;68546.28634284183;68884.3111568878;69258;6938.375546200866;7634;7737.845243094994;7963.009247688078;8159.755207343789;37715;39169.41245881371;40842.387364188966;42712.57287427086;45064;59657.40342596518;59933.70033149806;60949.39050609615;60972;60975.085373720314;10914.454277285946;10925.945370273097;11053.28153670009;11204.887951120385;11371.03346215548;11697;11758.11814113962;12086.39568021613;12244.387780611112;12754.234745915275;9369.765755856159;10611;11001.284916480403;11135.610253641084;11798.791148408875;10931.125509959344;11075.280106793032;11082.279651822606;11094.500747466545;11210.55157793679;11432.028277596164;11494;11598;11622.94188529052;11634.243774154653;9598;9761.658341957997;9989.300748947504;9990;10045.397276163454;9718;9743.464109474047;9743.853842192231;9757.658481953098;9784.412935223909 08:39:46 INFO - PROCESS | 1674 | __end_tp_report 08:39:46 INFO - PROCESS | 1674 | __start_cc_report 08:39:46 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1320 08:39:46 INFO - PROCESS | 1674 | __end_cc_report 08:39:46 INFO - PROCESS | 1674 | __startTimestamp1461944386877__endTimestamp 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | ------- Summary: start ------- 08:39:46 INFO - PROCESS | 1674 | Number of tests: 6 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5668.97 Median:5898.62 stddev:638.70 (10.8%) stddev-sans-first:601.14 08:39:46 INFO - PROCESS | 1674 | Values: 2849.4 3404.8 3412.6 3442.2 3467.1 4793.2 5551.9 5635.5 5672.3 5685.5 5407.4 5547.1 5565.0 5665.7 5695.0 5075.2 5126.7 5127.6 5130.9 5282.8 5224.8 5245.1 5251.3 5272.9 5275.6 5056.8 5115.2 5133.7 5190.1 5258.3 5171.9 5195.3 5197.0 5207.8 5224.0 5127.2 5149.8 5184.9 5208.6 5211.5 5405.5 5520.0 5533.8 5534.9 5560.6 5052.7 5987.5 6007.2 6043.6 6063.6 6209.4 6246.3 6265.7 6271.0 6284.6 5636.1 5740.8 5747.3 5779.5 5793.7 6143.5 6198.9 6227.1 6238.9 6248.2 6004.6 6046.8 6050.1 6063.0 6069.4 6095.2 6159.3 6206.4 6224.5 6226.6 6033.2 6047.5 6060.7 6070.3 6077.9 6063.1 6080.3 6086.1 6091.1 6104.8 4805.7 4816.1 4823.8 4828.0 4877.9 4311.5 4347.4 4384.1 4420.0 4431.1 5224.5 5600.2 5620.7 5622.7 5648.0 6113.1 6150.3 6228.5 6236.3 6267.7 5633.8 5644.0 5645.4 5670.0 5674.4 5288.8 5305.0 5318.3 5331.4 5342.2 6142.6 6184.0 6231.7 6257.1 6270.3 6188.7 6244.1 6246.2 6257.5 6262.5 6230.2 6250.1 6256.4 6263.5 6269.3 5965.0 6110.0 6132.6 6143.3 6181.0 6179.8 6227.6 6227.8 6229.2 6242.6 5899.8 6066.3 6075.3 6077.2 6119.3 5919.3 5973.0 5989.4 6030.1 6090.4 5835.9 5836.5 5840.8 5855.0 5880.0 6054.2 6076.4 6085.0 6089.9 6121.6 5800.7 5898.6 5907.3 5997.3 6016.5 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:63066.18 Median:33367.25 stddev:139005.16 (416.6%) stddev-sans-first:139315.73 08:39:46 INFO - PROCESS | 1674 | Values: 500.3 536.0 576.5 592.8 595.1 30336.0 30953.5 30970.5 31020.2 31127.8 39971.6 41184.0 41184.4 41227.2 41300.4 9862.3 10038.6 10063.8 10079.5 10090.1 8592.8 8831.3 9806.9 9948.3 9957.8 11581.4 11860.3 11869.6 11880.4 11914.7 11784.9 11862.3 11938.4 11939.0 11943.2 8531.6 8770.0 8778.6 8790.8 11676.8 37376.6 38110.0 38110.0 38152.8 38215.0 3241.5 3254.9 3268.0 3319.1 3414.0 27804.4 28750.4 28762.7 28779.4 28833.1 2711.8 2715.9 2803.6 2818.8 2873.5 486120.0 487681.0 487907.0 488206.0 488251.0 34172.5 34822.8 34827.8 34932.1 34950.7 35588.3 35984.6 36061.6 36151.5 36194.8 15423.5 15623.3 15630.5 15634.0 15643.9 13086.9 13129.0 13163.0 13382.9 13407.7 7558.8 7756.1 8093.6 8184.5 8261.5 3120.7 3367.0 3420.5 3462.3 3466.9 950.2 1004.0 1017.7 1106.6 1178.1 30161.5 30183.0 30266.9 30313.3 30412.7 1096.2 1112.6 1138.9 1205.5 1266.5 14218.0 15483.6 15542.7 15620.9 16040.1 629043.0 637647.0 638102.0 639243.0 640572.0 60711.0 63041.4 63151.1 63197.0 63210.4 1325.5 1361.6 1476.9 1485.8 1545.6 29740.9 30186.6 30339.4 30397.4 30448.3 50082.2 52004.5 52076.5 52150.8 52189.0 397330.0 409573.0 409865.0 410046.0 410488.0 22670.9 25506.0 25940.5 26239.6 26660.1 43565.1 43970.7 44067.6 44207.0 44937.6 30559.8 31530.0 37488.9 38879.8 39085.4 30243.5 36652.5 36902.6 37698.1 37852.2 36877.4 37257.6 37751.4 37822.8 38084.2 31456.5 32908.0 33149.5 33282.0 33452.5 24292.0 24348.3 24506.6 25089.5 25172.4 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35075.16 Median:25676.55 stddev:102381.88 (398.7%) stddev-sans-first:102635.97 08:39:46 INFO - PROCESS | 1674 | Values: 394.3 396.6 399.2 399.6 408.6 14352.5 20269.0 20853.8 20942.8 20961.5 16058.8 17377.7 19828.6 19906.3 20530.1 5934.0 6103.8 6137.7 6138.0 6143.9 5765.8 6050.9 6057.2 6061.8 6062.9 5980.5 6007.3 6012.9 6014.2 6035.3 5981.9 6060.8 6067.5 6078.5 6085.3 5096.0 5231.8 5255.2 5271.0 5272.2 25403.5 25949.6 25968.7 26349.0 26868.9 2361.4 2477.1 2482.7 2733.3 2919.5 14454.7 14971.8 15136.6 15144.2 15159.6 1741.5 1793.9 1802.6 1831.4 2036.4 110060.0 115161.0 115845.8 116218.0 117423.0 11529.2 11611.8 11627.1 11682.4 12071.6 14973.3 15104.5 15151.8 15152.2 15181.5 7578.5 7777.8 8834.4 8955.2 9051.5 8836.9 8842.2 8856.6 8964.7 8969.8 4634.3 4670.9 4713.3 4723.4 4724.7 1711.0 1936.8 1980.7 1986.4 2027.6 927.8 952.4 976.9 984.1 1108.2 20455.4 20591.0 21723.0 21805.0 21919.8 962.7 973.1 977.2 992.6 1005.0 10270.0 10753.5 10788.0 10796.3 10819.5 609662.0 610066.0 611238.0 619019.0 630186.0 88713.6 98412.7 136365.0 137656.0 140454.0 1019.4 1115.5 1145.5 1148.8 1149.0 17939.4 18081.9 18144.7 18224.8 18513.2 40267.0 44273.0 52052.7 52200.5 53065.0 72192.0 72795.3 73600.9 74257.0 74905.9 8048.8 8105.0 8385.8 8410.0 8656.7 9430.7 11326.5 12121.6 12912.8 12914.6 9651.4 10817.9 11047.6 11081.6 11219.6 9449.5 10313.5 10406.3 10784.5 10800.9 10347.9 10905.9 10985.7 11176.9 11487.9 8308.3 8357.1 8515.4 8561.6 8740.3 10698.1 11236.8 11482.9 11489.4 11562.3 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5722.25 Median:4892.08 stddev:3208.29 (65.6%) stddev-sans-first:3201.29 08:39:46 INFO - PROCESS | 1674 | Values: 1458.1 1632.4 1644.9 1929.3 2038.8 7904.0 8712.7 8939.4 8942.5 8942.8 8555.0 8780.4 8801.7 8807.0 8811.5 2122.5 2491.6 2492.6 2492.9 2493.6 2441.2 2466.8 2486.5 2487.8 2489.1 2443.2 2466.4 2469.9 2476.2 2477.5 2425.6 2444.6 2456.5 2460.6 2464.8 2406.9 2436.6 2438.8 2444.8 2445.7 8621.0 8791.5 8887.7 8897.2 8906.2 4684.2 5345.7 5551.8 5613.4 5614.1 3519.8 3520.4 3631.8 3690.2 3707.3 1007.2 1056.6 1057.4 1058.8 1068.4 11648.1 11707.6 11728.8 11732.5 11744.4 3989.9 4641.6 4782.0 4787.2 4795.8 9286.8 9321.9 9330.3 9336.0 9343.8 5286.7 5365.6 5377.4 5382.2 5407.5 4445.4 4642.8 4856.4 4941.2 4973.3 3451.9 3843.9 3856.5 3900.2 3966.1 1230.5 1244.7 1244.9 1258.7 1260.1 671.9 747.7 874.3 885.0 898.4 5488.2 5670.6 5960.5 6039.2 6049.5 503.5 504.2 506.9 514.2 660.9 3846.2 4013.5 4026.4 4068.4 4272.8 10469.6 10698.8 10825.4 10827.6 10833.7 10662.7 10783.4 10803.1 10819.8 10831.8 6701.8 7908.5 8222.5 8235.4 8311.3 5894.5 6022.8 6098.3 6128.5 6145.4 9810.3 10067.6 10229.4 10245.0 10250.7 10152.3 10161.4 10347.9 10407.5 10511.8 7591.8 7599.7 7666.1 7683.9 7739.4 8136.6 8301.2 8379.7 8379.7 8383.5 6872.3 7433.9 7571.3 7635.4 7745.6 7214.5 7368.8 7400.4 7483.8 7551.2 6927.4 7091.3 7092.3 7100.3 7114.4 4856.9 4891.4 4892.8 4947.8 5160.1 4423.4 4960.7 4984.3 5064.5 5281.5 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4656.04 Median:5107.23 stddev:1445.38 (28.3%) stddev-sans-first:1412.23 08:39:46 INFO - PROCESS | 1674 | Values: 315.3 316.3 324.1 324.6 327.8 4638.8 4939.6 5254.6 5307.7 5319.5 4333.4 4341.7 5036.8 5205.2 5235.9 3874.2 3919.6 3991.4 4120.4 4121.9 3313.0 3822.6 4085.4 4089.3 4144.4 3404.9 3450.7 3487.6 3579.4 4048.2 3377.4 3902.6 4078.6 4081.0 4103.0 3528.2 3553.8 3556.1 3564.4 3568.6 5019.7 5026.4 5043.4 5063.7 5097.9 4473.5 4676.2 4690.8 4715.5 4841.4 5475.6 5479.8 5496.5 5503.3 5507.8 3922.8 3941.2 3942.9 3953.7 3960.8 4777.9 5116.6 5484.4 5531.5 5555.0 3522.8 3755.9 3816.9 3983.3 4053.4 3882.3 4097.7 4097.7 4099.4 4108.5 3932.6 4421.8 4475.9 4660.4 4685.9 5085.6 5446.5 5524.4 5617.9 5685.7 1494.4 1509.1 1512.2 1514.5 1520.6 878.9 952.2 966.7 978.6 1011.4 4981.9 5380.0 5577.8 5624.0 5629.1 5435.6 6184.1 6202.2 6227.3 6261.4 5258.5 5318.9 5563.7 5595.6 5603.2 2794.0 3215.9 3251.9 3262.9 3271.8 5639.7 6321.2 6473.4 6502.4 6524.0 5070.7 5882.2 6336.5 6400.0 6405.6 5436.2 6172.8 6186.5 6403.4 6509.4 5223.8 5702.7 6178.1 6192.4 6208.8 6074.8 6102.9 6110.2 6119.4 6120.3 5154.8 5392.9 5433.0 6466.3 6511.4 4215.8 4215.9 4236.4 4242.0 4261.0 5212.4 5426.8 5839.0 6107.6 6163.4 4856.2 5090.9 5997.5 6003.2 6005.8 5366.9 5625.7 5989.8 5992.9 6013.6 5140.7 5297.7 5346.6 5883.4 5893.3 4941.2 4986.7 5251.5 5565.5 5588.6 4831.0 4868.8 5238.4 5445.2 5471.2 08:39:46 INFO - PROCESS | 1674 | 08:39:46 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:17688.92 Median:30795.75 stddev:24829.07 (80.6%) stddev-sans-first:24866.09 08:39:46 INFO - PROCESS | 1674 | Values: 737.9 749.7 753.0 757.7 768.8 12375.3 14658.3 14826.3 15044.9 15250.7 14075.9 14148.6 14202.0 14204.8 14211.0 714.5 738.4 911.9 913.9 916.8 824.5 934.6 934.8 936.8 937.4 962.4 972.5 973.0 973.3 973.5 757.7 933.9 964.3 967.0 977.6 724.7 724.7 725.9 726.0 726.1 14627.0 14667.2 14696.6 14702.2 14727.6 12423.3 12428.8 12495.6 12580.5 12882.0 9813.6 9936.1 9999.9 10072.4 10514.6 3508.5 3516.4 3517.6 3583.7 3590.3 75947.0 76083.0 76703.2 78175.6 78694.2 9479.2 9639.5 9654.5 9687.6 9913.7 18591.9 22139.2 22281.1 22334.8 22435.4 7231.0 7329.9 7468.4 7560.1 7639.1 3370.4 4018.9 4028.1 4034.8 4036.2 3547.8 3631.5 3635.0 3638.2 3643.8 625.9 633.5 637.4 641.0 668.0 501.2 502.6 544.9 596.5 616.4 8162.8 8185.6 8203.7 8274.5 8408.7 491.5 586.6 588.7 592.6 599.4 3768.8 3854.0 3897.8 3935.4 4106.9 92338.5 93259.0 94715.1 97118.5 97881.0 72445.5 75849.6 75870.0 76844.6 79867.4 66938.0 67440.9 68546.3 68884.3 69258.0 6938.4 7634.0 7737.8 7963.0 8159.8 37715.0 39169.4 40842.4 42712.6 45064.0 59657.4 59933.7 60949.4 60972.0 60975.1 10914.5 10925.9 11053.3 11204.9 11371.0 11697.0 11758.1 12086.4 12244.4 12754.2 9369.8 10611.0 11001.3 11135.6 11798.8 10931.1 11075.3 11082.3 11094.5 11210.6 11432.0 11494.0 11598.0 11622.9 11634.2 9598.0 9761.7 9989.3 9990.0 10045.4 9718.0 9743.5 9743.9 9757.7 9784.4 08:39:46 INFO - PROCESS | 1674 | -------- Summary: end -------- 08:39:46 INFO - PROCESS | 1674 | 08:39:47 INFO - TEST-INFO | 1674: exit 0 08:39:47 INFO - TEST-OK | dromaeo_css | took 1115426ms 08:39:47 INFO - TEST-START | kraken 08:39:47 INFO - operating with platform_type : mac_ 08:39:47 INFO - Initialising browser for kraken test... 08:39:47 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmp9gT3dC/profile http://localhost:49275/getInfo.html) 08:39:49 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 08:39:49 INFO - PROCESS | 1680 | colorDepth:24 08:39:49 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 08:39:49 INFO - PROCESS | 1680 | __metrics 08:39:49 INFO - PROCESS | 1680 | 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:39:49 ERROR - PROCESS | 1680 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:39:50 INFO - TEST-INFO | 1680: exit 0 08:39:50 INFO - Browser initialized. 08:39:50 INFO - Running cycle 1/1 for kraken test... 08:39:50 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmp9gT3dC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:02 INFO - PROCESS | 1682 | RSS: Main: 239714304 08:40:02 INFO - PROCESS | 1682 | 08:40:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:05 INFO - PROCESS | 1682 | RSS: Main: 287105024 08:40:05 INFO - PROCESS | 1682 | 08:40:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 08:40:09 INFO - PROCESS | 1682 | RSS: Main: 295620608 08:40:09 INFO - PROCESS | 1682 | 08:40:12 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 08:40:13 INFO - PROCESS | 1682 | RSS: Main: 382738432 08:40:13 INFO - PROCESS | 1682 | 08:40:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 08:40:16 INFO - PROCESS | 1682 | RSS: Main: 282320896 08:40:16 INFO - PROCESS | 1682 | 08:40:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:18 INFO - PROCESS | 1682 | RSS: Main: 286539776 08:40:18 INFO - PROCESS | 1682 | 08:40:21 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:22 INFO - PROCESS | 1682 | RSS: Main: 322768896 08:40:22 INFO - PROCESS | 1682 | 08:40:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:25 INFO - PROCESS | 1682 | RSS: Main: 324014080 08:40:25 INFO - PROCESS | 1682 | 08:40:28 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 08:40:29 INFO - PROCESS | 1682 | RSS: Main: 321908736 08:40:29 INFO - PROCESS | 1682 | 08:40:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:31 INFO - PROCESS | 1682 | RSS: Main: 314703872 08:40:31 INFO - PROCESS | 1682 | 08:40:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:33 INFO - PROCESS | 1682 | RSS: Main: 321437696 08:40:33 INFO - PROCESS | 1682 | 08:40:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:36 INFO - PROCESS | 1682 | RSS: Main: 323514368 08:40:36 INFO - PROCESS | 1682 | 08:40:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:40 INFO - PROCESS | 1682 | RSS: Main: 328146944 08:40:40 INFO - PROCESS | 1682 | 08:40:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:43 INFO - PROCESS | 1682 | RSS: Main: 325984256 08:40:43 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 08:40:45 INFO - PROCESS | 1682 | RSS: Main: 390385664 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | __start_tp_report 08:40:45 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 08:40:45 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 08:40:45 INFO - PROCESS | 1682 | |i|pagename|runs| 08:40:45 INFO - PROCESS | 1682 | |0;ai-astar;113;113;106;111;112;114;112;114;107;113 08:40:45 INFO - PROCESS | 1682 | |1;audio-beat-detection;156;123;141;168;120;145;168;146;189;117 08:40:45 INFO - PROCESS | 1682 | |2;audio-dft;187;187;186;183;184;181;181;185;185;257 08:40:45 INFO - PROCESS | 1682 | |3;audio-fft;76;73;87;89;61;60;57;83;85;56 08:40:45 INFO - PROCESS | 1682 | |4;audio-oscillator;87;94;138;78;80;78;145;115;111;130 08:40:45 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;91;87;90;88;88;87;90;89;90;86 08:40:45 INFO - PROCESS | 1682 | |6;imaging-darkroom;96;96;96;95;94;95;95;96;98;95 08:40:45 INFO - PROCESS | 1682 | |7;imaging-desaturate;82;85;87;82;86;88;83;85;83;83 08:40:45 INFO - PROCESS | 1682 | |8;json-parse-financial;60;59;59;59;58;59;58;82;60;58 08:40:45 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;69;72;75;70;69;68;67;66;68 08:40:45 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;83;83;81;91;103;111;81;80;83 08:40:45 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;135;138;135;135;132;134;137;139;169;134 08:40:45 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;170;169;169;171;172;171;171;179;169;164 08:40:45 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;70;69;70;67;74;71;64;68;67;67 08:40:45 INFO - PROCESS | 1682 | __end_tp_report 08:40:45 INFO - PROCESS | 1682 | __start_cc_report 08:40:45 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,2063 08:40:45 INFO - PROCESS | 1682 | __end_cc_report 08:40:45 INFO - PROCESS | 1682 | __startTimestamp1461944445517__endTimestamp 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | ------- Summary: start ------- 08:40:45 INFO - PROCESS | 1682 | Number of tests: 14 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:2.80 (2.5%) stddev-sans-first:2.92 08:40:45 INFO - PROCESS | 1682 | Values: 113.0 113.0 106.0 111.0 112.0 114.0 112.0 114.0 107.0 113.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:151.00 stddev:23.50 (15.6%) stddev-sans-first:24.72 08:40:45 INFO - PROCESS | 1682 | Values: 156.0 123.0 141.0 168.0 120.0 145.0 168.0 146.0 189.0 117.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:191.60 Median:185.50 stddev:23.08 (12.4%) stddev-sans-first:24.42 08:40:45 INFO - PROCESS | 1682 | Values: 187.0 187.0 186.0 183.0 184.0 181.0 181.0 185.0 185.0 257.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:72.70 Median:79.50 stddev:13.17 (16.6%) stddev-sans-first:13.92 08:40:45 INFO - PROCESS | 1682 | Values: 76.0 73.0 87.0 89.0 61.0 60.0 57.0 83.0 85.0 56.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:78.00 stddev:25.76 (33.0%) stddev-sans-first:26.43 08:40:45 INFO - PROCESS | 1682 | Values: 87.0 94.0 138.0 78.0 80.0 78.0 145.0 115.0 111.0 130.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.50 stddev:1.65 (1.8%) stddev-sans-first:1.50 08:40:45 INFO - PROCESS | 1682 | Values: 91.0 87.0 90.0 88.0 88.0 87.0 90.0 89.0 90.0 86.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:1.07 (1.1%) stddev-sans-first:1.13 08:40:45 INFO - PROCESS | 1682 | Values: 96.0 96.0 96.0 95.0 94.0 95.0 95.0 96.0 98.0 95.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:2.12 (2.5%) stddev-sans-first:2.06 08:40:45 INFO - PROCESS | 1682 | Values: 82.0 85.0 87.0 82.0 86.0 88.0 83.0 85.0 83.0 83.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:59.00 stddev:7.35 (12.4%) stddev-sans-first:7.78 08:40:45 INFO - PROCESS | 1682 | Values: 60.0 59.0 59.0 59.0 58.0 59.0 58.0 82.0 60.0 58.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:3.27 (4.7%) stddev-sans-first:2.74 08:40:45 INFO - PROCESS | 1682 | Values: 63.0 69.0 72.0 75.0 70.0 69.0 68.0 67.0 66.0 68.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:82.50 stddev:10.73 (13.0%) stddev-sans-first:11.17 08:40:45 INFO - PROCESS | 1682 | Values: 82.0 83.0 83.0 81.0 91.0 103.0 111.0 81.0 80.0 83.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:136.00 stddev:10.81 (7.9%) stddev-sans-first:11.38 08:40:45 INFO - PROCESS | 1682 | Values: 135.0 138.0 135.0 135.0 132.0 134.0 137.0 139.0 169.0 134.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:3.72 (2.2%) stddev-sans-first:3.94 08:40:45 INFO - PROCESS | 1682 | Values: 170.0 169.0 169.0 171.0 172.0 171.0 171.0 179.0 169.0 164.0 08:40:45 INFO - PROCESS | 1682 | 08:40:45 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:2.75 (4.0%) stddev-sans-first:2.88 08:40:45 INFO - PROCESS | 1682 | Values: 70.0 69.0 70.0 67.0 74.0 71.0 64.0 68.0 67.0 67.0 08:40:45 INFO - PROCESS | 1682 | -------- Summary: end -------- 08:40:45 INFO - PROCESS | 1682 | 08:40:46 INFO - TEST-INFO | 1682: exit 0 08:40:46 INFO - TEST-OK | kraken | took 58824ms 08:40:46 INFO - SUITE-END | took 1174s 08:40:46 INFO - Completed test suite (00:19:34) 08:40:46 INFO - javascript benchmark 08:40:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2849.3873817129315, 3404.812735299559, 3412.5904891413034, 3442.208292092817, 3467.133216695826, 4793.185158523046, 5551.8889622207535, 5635.464630860061, 5672.290963629546, 5685.545156387484, 5407.3781515125775, 5547.11246200608, 5565.0, 5665.660060396379, 5694.971525142379, 5075.162598171298, 5126.71803050832, 5127.615428842833, 5130.897382052357, 5282.815101471449, 5224.764885580139, 5245.082110630643, 5251.264822924793, 5272.868178295555, 5275.57795376369, 5056.84829455117, 5115.155999260155, 5133.691978481284, 5190.143626301656, 5258.316418865561, 5171.922421163686, 5195.298634684307, 5196.9740151299, 5207.817726379559, 5224.03355379256, 5127.179651255781, 5149.794008239666, 5184.896302073975, 5208.583313334924, 5211.452797456288, 5405.5135037846785, 5519.972400138014, 5533.833984980457, 5534.916976245359, 5560.582956278296, 5052.671576347526, 5987.520998320124, 6007.15899774032, 6043.576949613529, 6063.646931415128, 6209.410106039919, 6246.344133865924, 6265.686715664244, 6271.0, 6284.591501552431, 5636.070048442043, 5740.827775166752, 5747.281589801275, 5779.450952159538, 5793.65238085712, 6143.481172719164, 6198.876022479525, 6227.06594010893, 6238.906416403757, 6248.156498872685, 6004.579679422399, 6046.848828779316, 6050.122732203894, 6062.969685151546, 6069.423404776539, 6095.238095238095, 6159.260888693296, 6206.410391012937, 6224.502039836802, 6226.5641405102115, 6033.245844269466, 6047.5464340173785, 6060.727267272983, 6070.332263451017, 6077.908831367533, 6063.120847477091, 6080.270367555921, 6086.147939288503, 6091.08633704939, 6104.816855494342, 4805.663603547788, 4816.060868130751, 4823.831165909176, 4827.961988172559, 4877.926831097537, 4311.48262208537, 4347.369631403429, 4384.101259241847, 4419.955800441954, 4431.113777244564, 5224.477552244821, 5600.187972743929, 5620.662760234399, 5622.662640241599, 5647.971760141173, 6113.081058499921, 6150.261968563801, 6228.532860035515, 6236.251649802053, 6267.655278959701, 5633.8309850704545, 5644.0, 5645.407232240637, 5670.036093864053, 5674.432556744293, 5288.8413347599635, 5305.0, 5318.25544423781, 5331.413544510178, 5342.198670199501, 6142.560166306883, 6184.041473571604, 6231.688415579112, 6257.092721555349, 6270.341614130451, 6188.659623720739, 6244.063390491463, 6246.156768836331, 6257.4994000480765, 6262.530310226843, 6230.221222347207, 6250.0937364082865, 6256.374362563707, 6263.498920086473, 6269.341719119427, 5964.970175149097, 6109.969450152721, 6132.5707200495535, 6143.296949342275, 6180.969095154495, 6179.81460556184, 6227.564070515021, 6227.844303892258, 6229.190205273467, 6242.563020588515, 5899.764009439575, 6066.3023752269055, 6075.301340345917, 6077.24034495688, 6119.326874043941, 5919.260092488439, 5972.9701351494705, 5989.371116032754, 6030.125631783455, 6090.390960903874, 5835.912461313169, 5836.474717275466, 5840.766369345349, 5854.970725146347, 5880.0, 6054.152418661479, 6076.392360763888, 6085.026395776655, 6089.850084553785, 6121.571489995657, 5800.6809625471005, 5898.616589921641, 5907.320658124198, 5997.250343707036, 6016.548758843017], "value": 5627.743124183761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.33955179163496, 535.9575625408581, 576.495566379418, 592.7777083593652, 595.1103100864209, 30336.0, 30953.535696964536, 30970.53544196839, 31020.224494387596, 31127.84436077822, 39971.60028399722, 41184.0, 41184.38223426651, 41227.175456490855, 41300.380494292534, 9862.30963832532, 10038.598456061749, 10063.849042264372, 10079.496025198747, 10090.142337901287, 8592.828143437158, 8831.293496520262, 9806.901930980706, 9948.25388095892, 9957.800843983116, 11581.36302503362, 11860.288382697066, 11869.643910682693, 11880.405979701023, 11914.702132446671, 11784.882151178464, 11862.288262704265, 11938.403079845973, 11938.985186259179, 11943.223690460092, 8531.57342132897, 8770.0, 8778.64885404583, 8790.780230494225, 11676.766464670744, 37376.62623373759, 38110.0, 38110.04724881872, 38152.80923595392, 38215.04462388463, 3241.529978153178, 3254.8535315910603, 3267.950980735291, 3319.0872510059685, 3414.0440676610588, 27804.443911121663, 28750.424991500262, 28762.712372876424, 28779.424411511653, 28833.135005949644, 2711.755941965213, 2715.91852244433, 2803.5654473556633, 2818.802683812134, 2873.4971380008415, 486120.0, 487681.0, 487907.0, 488206.0, 488251.0, 34172.48741268883, 34822.82588587041, 34827.82586087104, 34932.12669683278, 34950.650493495246, 35588.28823423517, 35984.64015359813, 36061.63938360635, 36151.45772813357, 36194.819025904704, 15423.460178893685, 15623.296951637203, 15630.531084067496, 15634.0, 15643.921780391025, 13086.869131308566, 13129.0, 13163.0, 13382.866171338163, 13407.731845363038, 7558.848823023509, 7756.146823849372, 8093.55485448306, 8184.468009579477, 8261.504309741315, 3120.719135277836, 3366.966330336665, 3420.538227339327, 3462.3421549905943, 3466.930661386758, 950.1970834644715, 1003.9598416063276, 1017.699778565325, 1106.6112029403048, 1178.1077454848328, 30161.547576786365, 30183.0, 30266.940657077335, 30313.298050445515, 30412.69587304143, 1096.1504833753904, 1112.6439539347493, 1138.869030061537, 1205.5209074755257, 1266.4934026389517, 14218.0, 15483.612909677347, 15542.689146217012, 15620.921895390678, 16040.11779352147, 629043.0, 637647.0, 638102.0, 639243.0, 640572.0, 60711.0, 63041.36958630355, 63151.05273420902, 63197.0, 63210.36789632045, 1325.4896864707157, 1361.6459720472749, 1476.9187694676896, 1485.8068451101287, 1545.5904185390655, 29740.851295744247, 30186.593363909557, 30339.393212136074, 30397.392052159274, 30448.26501415674, 50082.2487662678, 52004.47995519996, 52076.47923520716, 52150.82793376597, 52189.0, 397330.0, 409573.0, 409865.0, 410046.0, 410488.0, 22670.886645566665, 25506.0, 25940.481190376464, 26239.606405903545, 26660.06689765849, 43565.12869742524, 43970.680879573665, 44067.644686127154, 44207.0, 44937.550624494645, 30559.847200763856, 31530.0, 37488.875333740034, 38879.80560097181, 39085.43658253638, 30243.546346805255, 36652.45021324736, 36902.630973691, 37698.057548561505, 37852.242955140195, 36877.44683829798, 37257.6274237265, 37751.43372849355, 37822.81088594539, 38084.23831523409, 31456.52815207728, 32908.0, 33149.502757458176, 33282.0, 33452.498212527316, 24292.0, 24348.269551913472, 24506.63240051365, 25089.49821003606, 25172.370690732147], "value": 18278.459111993863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.30798947846534, 396.5954726179297, 399.2175336340772, 399.64232012348947, 408.6036544551784, 14352.497662581813, 20268.986550672464, 20853.791462085373, 20942.790572094276, 20961.47596310091, 16058.75911861323, 17377.73933390997, 19828.60342793147, 19906.303279385225, 20530.076146573403, 5933.970330148343, 6103.755849766027, 6137.693115344215, 6138.0, 6143.87712245757, 5765.769369225226, 6050.939490605082, 6057.242844644419, 6061.757529698807, 6062.878367502004, 5980.491658209035, 6007.339192688823, 6012.909806352908, 6014.1580178775, 6035.275766907956, 5981.850453738648, 6060.787872424466, 6067.453929146398, 6078.544109191784, 6085.330613632497, 5095.974520127375, 5231.843044708665, 5255.211718242294, 5271.024860400838, 5272.235525848769, 25403.491930161294, 25949.61075583868, 25968.74031259682, 26349.0, 26868.86565567179, 2361.3860396296914, 2477.071098338123, 2482.689663792026, 2733.316670832292, 2919.459899918522, 14454.71090578193, 14971.775423368657, 15136.621584460367, 15144.167070811101, 15159.62100947474, 1741.5123765345722, 1793.8923664580168, 1802.567383827885, 1831.4139475367888, 2036.4196204081766, 110060.0, 115161.0, 115845.84154158435, 116218.0, 117423.0, 11529.192956492965, 11611.767764644828, 11627.069834413227, 11682.415879206006, 12071.57749478764, 14973.326200321011, 15104.54686359411, 15151.772723409158, 15152.166630835189, 15181.544553663407, 7578.469507134558, 7777.805554861061, 8834.381385015166, 8955.194032537103, 9051.456912585267, 8836.8674469883, 8842.248408885316, 8856.601452934634, 8964.731058068268, 8969.775755606031, 4634.328022436728, 4670.883227919329, 4713.29300604912, 4723.362346083303, 4724.71651700899, 1710.9572260693583, 1936.7579052618423, 1980.742503474539, 1986.4140078676537, 2027.6046170996515, 927.8376284150247, 952.3857112162616, 976.9364991275544, 984.0503913723148, 1108.1688733449912, 20455.386338409873, 20591.0, 21723.0, 21805.018774154883, 21919.780802192094, 962.7496850818698, 973.1387721866199, 977.203579083045, 992.6178421307849, 1004.9547770350351, 10270.0, 10753.515322560597, 10788.006029820854, 10796.298240614493, 10819.459027048617, 609662.0, 610066.0, 611238.0, 619019.0, 630186.0, 88713.55643221743, 98412.68254150721, 136365.0, 137656.0, 140454.0, 1019.4393083804026, 1115.4590023838432, 1145.5017067575632, 1148.7702459507964, 1148.9885101149048, 17939.37212197567, 18081.909590451964, 18144.72782908284, 18224.817751822844, 18513.166907489463, 40267.0, 44273.0, 52052.69868253172, 52200.47799521956, 53065.0, 72192.0, 72795.27204727885, 73600.89598656131, 74257.0, 74905.87641185278, 8048.798780030546, 8104.959475202822, 8385.832283354177, 8409.957950210455, 8656.697015604424, 9430.669926552811, 11326.490307935997, 12121.636350909486, 12912.8063079052, 12914.612561623166, 9651.372660777028, 10817.945910270399, 11047.558097676003, 11081.5567377304, 11219.60731374398, 9449.480278584744, 10313.535890885078, 10406.323588966692, 10784.460776960963, 10800.945995270287, 10347.896521034694, 10905.945470272598, 10985.670429887115, 11176.888231117584, 11487.885121149016, 8308.293795027248, 8357.080721120794, 8515.361347899056, 8561.57192140378, 8740.282888397494, 10698.090662293793, 11236.775264494829, 11482.885171148182, 11489.425528723697, 11562.30626162433], "value": 9717.956637720346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.0886945658963, 1632.3715369582708, 1644.868410527158, 1929.2765213045109, 2038.7757346691872, 7904.0, 8712.651493940242, 8939.374243802937, 8942.508162051092, 8942.821143577125, 8555.0, 8780.42927209731, 8801.691940782073, 8806.95596522018, 8811.471311721301, 2122.546055951674, 2491.638712386703, 2492.6136448850457, 2492.8628925409093, 2493.6384224287467, 2441.182203961675, 2466.8149888758326, 2486.5151295497385, 2487.776100150986, 2489.0790407549234, 2443.218170185541, 2466.3710753757855, 2469.876506174693, 2476.1704828882257, 2477.54165479386, 2425.611902095674, 2444.5844206484853, 2456.45957889265, 2460.6309053641917, 2464.827462077655, 2406.867622280774, 2436.5979613363775, 2438.829281950264, 2444.841085329448, 2445.730969593343, 8620.956895215484, 8791.516466594334, 8887.733367998906, 8897.199252067345, 8906.153915378029, 4684.227102528079, 5345.663584103974, 5551.805686800983, 5613.410591887875, 5614.101743720985, 3519.788812671248, 3520.436730123168, 3631.7639353442205, 3690.206605579813, 3707.3141468828353, 1007.2445665750687, 1056.572088304238, 1057.3550134417999, 1058.772363941756, 1068.3856782350101, 11648.12639052066, 11707.590234341757, 11728.765424691459, 11732.53069877204, 11744.412779361082, 3989.940150897739, 4641.605463535638, 4781.952180478151, 4787.234042553175, 4795.784189711471, 9286.767830804283, 9321.906780932239, 9330.346875718635, 9336.019717929656, 9343.813123737487, 5286.682799032071, 5365.6244062916, 5377.354717433933, 5382.219578161144, 5407.459254074561, 4445.399871017371, 4642.79107440166, 4856.4415092264135, 4941.234108713155, 4973.278874563168, 3451.930961380758, 3843.9044872211284, 3856.537215534154, 3900.239453306578, 3966.087799806061, 1230.501646833034, 1244.7261602447447, 1244.8568414632434, 1258.672745086284, 1260.1493991555662, 671.8521925176453, 747.6915398053407, 874.3355050161923, 884.9734108890697, 898.3980732908967, 5488.1767734839295, 5670.5747068969995, 5960.523158147338, 6039.1545183674325, 6049.455549000523, 503.52920019781624, 504.2209785880823, 506.94170170430135, 514.1901505129437, 660.8777376185421, 3846.1922996171115, 4013.4983127109113, 4026.416169655384, 4068.4100805383646, 4272.829086836554, 10469.581216751398, 10698.78602427947, 10825.350478971286, 10827.621033263798, 10833.729156770985, 10662.73343166427, 10783.406912619725, 10803.13574914005, 10819.83770243447, 10831.783364332668, 6701.765438209639, 7908.52548847071, 8222.506649601042, 8235.38234632405, 8311.293540049042, 5894.528437724886, 6022.849428764316, 6098.329183789869, 6128.509719222362, 6145.4161854623735, 9810.264230182907, 10067.597296108366, 10229.43738094412, 10244.975502449695, 10250.692479225636, 10152.289339746147, 10161.390316581028, 10347.94826025865, 10407.47962601882, 10511.789764204826, 7591.848163036819, 7599.734009309647, 7666.080070391588, 7683.884741728767, 7739.419543534144, 8136.633851476579, 8301.169883011651, 8379.664813407395, 8379.70671026511, 8383.538905360263, 6872.278410766798, 7433.8884916727375, 7571.318581327707, 7635.427342949412, 7745.573993430416, 7214.494985350975, 7368.778936631909, 7400.40796736249, 7483.812904677427, 7551.244875512624, 6927.445804335742, 7091.326323999212, 7092.290770922867, 7100.254473280231, 7114.395276401564, 4856.854294371175, 4891.364122664031, 4892.80428782859, 4947.752612369439, 5160.122779127632, 4423.447069116361, 4960.652754307164, 4984.277279794482, 5064.544191022678, 5281.498257665516], "value": 4543.750160531546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.25599584979454, 316.3388517997386, 324.0553785714642, 324.55211807705365, 327.81478464667475, 4638.837640682576, 4939.629527785417, 5254.553362964152, 5307.70807605582, 5319.521243088121, 4333.414988976488, 4341.674374421923, 5036.8415264489095, 5205.245239440288, 5235.895282094356, 3874.249283009067, 3919.627635374635, 3991.42124391963, 4120.402541631462, 4121.9175616487655, 3312.989538190851, 3822.636849499293, 4085.3871919212206, 4089.26393249215, 4144.399062135988, 3404.9489257661153, 3450.6721861423125, 3487.581490221164, 3579.4093974494176, 4048.1903619276113, 3377.3788581480903, 3902.64876161144, 4078.5921407859273, 4080.9795951020055, 4102.9895351277955, 3528.2414280929725, 3553.8045407502577, 3556.0931962349696, 3564.3940530109944, 3568.553930758655, 5019.673721208146, 5026.396832380101, 5043.445221025684, 5063.721495317756, 5097.898042039175, 4473.530279320657, 4676.18166820805, 4690.7654617269, 4715.528447155257, 4841.443234028062, 5475.561955043587, 5479.7944452220445, 5496.477834605706, 5503.3120859892515, 5507.834764957058, 3922.784246866421, 3941.1723538057045, 3942.8817135485983, 3953.695280557409, 3960.772160630214, 4777.928331075037, 5116.565091967187, 5484.369297530795, 5531.529819965308, 5555.0, 3522.7534072615185, 3755.9248815023548, 3816.904577385588, 3983.3029219886403, 4053.43251944728, 3882.3400021996326, 4097.651699605507, 4097.713160078825, 4099.405586189986, 4108.548059713429, 3932.567417584121, 4421.823127074946, 4475.910481790346, 4660.39414876064, 4685.922237885306, 5085.618578606619, 5446.494612478305, 5524.4199359067525, 5617.887642247214, 5685.658860468385, 1494.424646511101, 1509.1020842598637, 1512.160750783304, 1514.48507507448, 1520.5666385080199, 878.9077146899612, 952.2429668413628, 966.6858271061792, 978.5645387802502, 1011.4487604255698, 4981.850544483671, 5380.0046991306735, 5577.800772833779, 5623.971880140573, 5629.071203251499, 5435.646682965595, 6184.134221209034, 6202.162708034448, 6227.346128656516, 6261.373862613702, 5258.50044245796, 5318.8936221276135, 5563.721813909288, 5595.580331475075, 5603.2435621191435, 2793.972060279412, 3215.9196020099685, 3251.9349613007607, 3262.869485220612, 3271.7709760316548, 5639.689817060019, 6321.209848768904, 6473.352664733489, 6502.44729198014, 6523.967380163069, 5070.7464626768515, 5882.235309409835, 6336.461400780985, 6399.968000159969, 6405.583637063576, 5436.211749296409, 6172.845678858064, 6186.4741496973265, 6403.391677790602, 6509.381608747161, 5223.764930578209, 5702.743376547983, 6178.104174894525, 6192.442680158807, 6208.844778880564, 6074.757009719739, 6102.938970610237, 6110.205673262448, 6119.44924956756, 6120.296165940974, 5154.768035438339, 5392.946070539401, 5433.0, 6466.288708242184, 6511.38141876521, 4215.789210539399, 4215.88279106031, 4236.364545318227, 4242.0, 4261.019965408035, 5212.374515058217, 5426.833230855385, 5838.978478508395, 6107.6180289687945, 6163.3836616338, 4856.191520684438, 5090.949090509195, 5997.460228579449, 6003.159557662018, 6005.789797357072, 5366.919496207638, 5625.690587017753, 5989.790357337472, 5992.8801423972145, 6013.579049466495, 5140.717260550706, 5297.682139071668, 5346.625736198429, 5883.411658834082, 5893.292804863444, 4941.160002799605, 4986.650934434555, 5251.474852514718, 5565.499105080562, 5588.636738611977, 4831.043427411903, 4868.829590964299, 5238.371395432572, 5445.1832225166545, 5471.234027236111], "value": 4210.24639633406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9409647228222, 749.6589051981349, 753.0361137743687, 757.6628400361841, 768.8039549914772, 12375.257484550933, 14658.340374683139, 14826.258687065643, 15044.924775376121, 15250.6949861003, 14075.859241407583, 14148.575542733735, 14202.0, 14204.78692819606, 14211.0, 714.4641518860855, 738.3797610007592, 911.9361644684891, 913.876626655403, 916.8487199612056, 824.5135370131621, 934.5700977550301, 934.7849994501269, 936.7611259128912, 937.4141161773891, 962.4417837654179, 972.4943029624591, 972.951352432379, 973.3186769261546, 973.4791886340809, 757.7007082202555, 933.869258303838, 964.3056998960737, 967.0426277984815, 977.5991843344266, 724.6775185042658, 724.7209824217662, 725.872972229863, 726.0416250549277, 726.0561270348526, 14627.0, 14667.193304368255, 14696.55910322692, 14702.191379474125, 14727.55817325482, 12423.254604723656, 12428.813567796491, 12495.562655307112, 12580.496780128784, 12882.0, 9813.558389872473, 9936.105750482491, 9999.900001000042, 10072.395656260574, 10514.631987880464, 3508.5088087667746, 3516.4197907345256, 3517.56030496188, 3583.677469027774, 3590.299891521154, 75947.0, 76083.0, 76703.23296767073, 78175.60912195459, 78694.21305786926, 9479.194268487117, 9639.518024098767, 9654.469004204837, 9687.58073812021, 9913.65302214419, 18591.90704046471, 22139.225127120797, 22281.10875564959, 22334.776652233595, 22435.439114021952, 7231.023811785447, 7329.853402932018, 7468.439867009996, 7560.054993125859, 7639.083310002835, 3370.443876760307, 4018.9397159042055, 4028.093678922219, 4034.8184331705143, 4036.1725846201457, 3547.787132772042, 3631.4915911772373, 3635.0003748969243, 3638.21778317663, 3643.8360273787744, 625.9436650701459, 633.5027003801994, 637.4263163153199, 641.0, 667.9532432729662, 501.1532502727461, 502.60294367450035, 544.923710680505, 596.5496050481859, 616.4113271825486, 8162.795930101795, 8185.631646575918, 8203.671853125927, 8274.462159959583, 8408.705695300636, 491.5453205784635, 586.633354153654, 588.6968211371147, 592.6177615438105, 599.4365296621162, 3768.773873567595, 3853.967495219872, 3897.824597893102, 3935.4293627424436, 4106.917861642751, 92338.53830730803, 93259.0, 94715.052849472, 97118.51440742752, 97881.0, 72445.46099537099, 75849.62075189699, 75870.0, 76844.61577692076, 79867.40265194779, 66938.0, 67440.9187035364, 68546.28634284183, 68884.3111568878, 69258.0, 6938.375546200866, 7634.0, 7737.845243094994, 7963.009247688078, 8159.755207343789, 37715.0, 39169.41245881371, 40842.387364188966, 42712.57287427086, 45064.0, 59657.40342596518, 59933.70033149806, 60949.39050609615, 60972.0, 60975.085373720314, 10914.454277285946, 10925.945370273097, 11053.28153670009, 11204.887951120385, 11371.03346215548, 11697.0, 11758.11814113962, 12086.39568021613, 12244.387780611112, 12754.234745915275, 9369.765755856159, 10611.0, 11001.284916480403, 11135.610253641084, 11798.791148408875, 10931.125509959344, 11075.280106793032, 11082.279651822606, 11094.500747466545, 11210.55157793679, 11432.028277596164, 11494.0, 11598.0, 11622.94188529052, 11634.243774154653, 9598.0, 9761.658341957997, 9989.300748947504, 9990.0, 10045.397276163454, 9718.0, 9743.464109474047, 9743.853842192231, 9757.658481953098, 9784.412935223909], "value": 6802.4828902014115, "unit": "score"}], "name": "dromaeo_css", "value": 7118.361783171784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 106.0, 111.0, 112.0, 114.0, 112.0, 114.0, 107.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 141.0, 168.0, 120.0, 145.0, 168.0, 146.0, 189.0, 117.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 186.0, 183.0, 184.0, 181.0, 181.0, 185.0, 185.0, 257.0], "value": 191.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 87.0, 89.0, 61.0, 60.0, 57.0, 83.0, 85.0, 56.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 138.0, 78.0, 80.0, 78.0, 145.0, 115.0, 111.0, 130.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 88.0, 87.0, 90.0, 89.0, 90.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0, 98.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 87.0, 82.0, 86.0, 88.0, 83.0, 85.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 82.0, 60.0, 58.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 72.0, 75.0, 70.0, 69.0, 68.0, 67.0, 66.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 81.0, 91.0, 103.0, 111.0, 81.0, 80.0, 83.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 135.0, 135.0, 132.0, 134.0, 137.0, 139.0, 169.0, 134.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 169.0, 171.0, 172.0, 171.0, 171.0, 179.0, 169.0, 164.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 67.0, 74.0, 71.0, 64.0, 68.0, 67.0, 67.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1493.0, "alertThreshold": 2.0}]} 08:40:46 INFO - Return code: 0 08:40:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:40:46 ERROR - # TBPL SUCCESS # 08:40:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:46 INFO - 2016-04-29 08:40:46.844 screenresolution[1686:10205] starting screenresolution argv=screenresolution get 08:40:46 INFO - 2016-04-29 08:40:46.846 screenresolution[1686:10205] Display 0: 1600x1200x32@60 08:40:46 INFO - 2016-04-29 08:40:46.852 screenresolution[1687:10208] starting screenresolution argv=screenresolution list 08:40:46 INFO - Available Modes on Display 0 08:40:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:47 INFO - Intel Iris: 08:40:47 INFO - Chipset Model: Intel Iris 08:40:47 INFO - Type: GPU 08:40:47 INFO - Bus: Built-In 08:40:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:47 INFO - Vendor: Intel (0x8086) 08:40:47 INFO - Device ID: 0x0a2e 08:40:47 INFO - Revision ID: 0x0009 08:40:47 INFO - Displays: 08:40:47 INFO - Display: 08:40:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:47 INFO - Display Serial Number: 1600x1200 60 08:40:47 INFO - Main Display: Yes 08:40:47 INFO - Mirror: Off 08:40:47 INFO - Online: Yes 08:40:47 INFO - Rotation: Supported 08:40:47 INFO - Return code: 0 08:40:47 INFO - Running post-action listener: _resource_record_post_action 08:40:47 INFO - Running post-run listener: _resource_record_post_run 08:40:48 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32620032; Write bytes: 697657856; Read time: 323; Write time: 1861 08:40:48 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 389546496; Write bytes: 384427520; Read time: 29402; Write time: 726 08:40:48 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30838272; Write bytes: 297591808; Read time: 304; Write time: 1101 08:40:48 INFO - Running post-run listener: _upload_blobber_files 08:40:48 INFO - Blob upload gear active. 08:40:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:48 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 08:40:48 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'] 08:40:48 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 08:40:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:49 INFO - (blobuploader) - INFO - Done attempting. 08:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:50 INFO - (blobuploader) - INFO - Done attempting. 08:40:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:50 INFO - Return code: 0 08:40:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0870b25dd24ba7dbfb80324b80481beeae0ca24249044b0cf9a02fe34531a03046d030d6cc2d88b5105eee2bb303bbaee36c0e6a33977a0b3c12e35c5bda51d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d0171a5f108710010948b589890773c5bb7fd1e62c753988bfd698e961d593f95cc793d008f5ec1fd7ad66ea53fcb45efeecaa4460a808110ee4b7d9f6758"} 08:40:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:50 INFO - Contents: 08:40:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0870b25dd24ba7dbfb80324b80481beeae0ca24249044b0cf9a02fe34531a03046d030d6cc2d88b5105eee2bb303bbaee36c0e6a33977a0b3c12e35c5bda51d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d0171a5f108710010948b589890773c5bb7fd1e62c753988bfd698e961d593f95cc793d008f5ec1fd7ad66ea53fcb45efeecaa4460a808110ee4b7d9f6758"} 08:40:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:50 INFO - Copying logs to upload dir... 08:40:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.199379 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-29 08:40:51.010717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:40:51.014286) ========= 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.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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/0870b25dd24ba7dbfb80324b80481beeae0ca24249044b0cf9a02fe34531a03046d030d6cc2d88b5105eee2bb303bbaee36c0e6a33977a0b3c12e35c5bda51d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d0171a5f108710010948b589890773c5bb7fd1e62c753988bfd698e961d593f95cc793d008f5ec1fd7ad66ea53fcb45efeecaa4460a808110ee4b7d9f6758"} build_url:https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010856 build_url: 'https://queue.taskcluster.net/v1/task/WTNXCZbQQt24ZeMC2xpkGw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0870b25dd24ba7dbfb80324b80481beeae0ca24249044b0cf9a02fe34531a03046d030d6cc2d88b5105eee2bb303bbaee36c0e6a33977a0b3c12e35c5bda51d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d0171a5f108710010948b589890773c5bb7fd1e62c753988bfd698e961d593f95cc793d008f5ec1fd7ad66ea53fcb45efeecaa4460a808110ee4b7d9f6758"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:40:51.043132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:40:51.043598) ========= 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.daYNdjVjzR/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.5l8jlMBCJO/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:40:51.094272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:40:51.094769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:40:51.095470) ========= ========= Total master_lag: 0.34 =========