builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1461689310.67 results: success (0) buildid: 20160426084357 builduid: f8ee86fbc5814290997e348edec02a2b revision: 8c55d8beba757967f6f5f7ff386499e8c6823c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.674496) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.674935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.675237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.723523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.723911) ========= 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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-26 09:48:30-- 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% 207M=0s 2016-04-26 09:48:30 (207 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.819092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.819413) ========= 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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.020150 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:30.868034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 09:48:30.868444) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8c55d8beba757967f6f5f7ff386499e8c6823c11 --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 8c55d8beba757967f6f5f7ff386499e8c6823c11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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-26 09:48:30,939 truncating revision to first 12 chars 2016-04-26 09:48:30,939 Setting DEBUG logging. 2016-04-26 09:48:30,940 attempt 1/10 2016-04-26 09:48:30,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8c55d8beba75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 09:48:32,651 unpacking tar archive at: fx-team-8c55d8beba75/testing/mozharness/ program finished with exit code 0 elapsedTime=1.951155 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 09:48:32.839084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:32.839636) ========= script_repo_revision: 8c55d8beba757967f6f5f7ff386499e8c6823c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:32.840310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:32.840783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 09:48:32.862200) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-26 09:48:32.862879) ========= /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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:48:33 INFO - MultiFileLogger online at 20160426 09:48:33 in /builds/slave/test 09:48:33 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 09:48:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:33 INFO - {'append_to_log': False, 09:48:33 INFO - 'base_work_dir': '/builds/slave/test', 09:48:33 INFO - 'blob_upload_branch': 'Fx-Team', 09:48:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:33 INFO - 'branch': 'Fx-Team', 09:48:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:33 INFO - 'config_files': ('talos/mac_config.py',), 09:48:33 INFO - 'default_actions': ('clobber', 09:48:33 INFO - 'read-buildbot-config', 09:48:33 INFO - 'download-and-extract', 09:48:33 INFO - 'populate-webroot', 09:48:33 INFO - 'create-virtualenv', 09:48:33 INFO - 'install', 09:48:33 INFO - 'run-tests'), 09:48:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:33 INFO - 'download_minidump_stackwalk': True, 09:48:33 INFO - 'download_symbols': 'ondemand', 09:48:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:33 INFO - 'installer_path': 'installer.exe', 09:48:33 INFO - 'log_level': 'info', 09:48:33 INFO - 'log_name': 'talos', 09:48:33 INFO - 'log_to_console': True, 09:48:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:33 INFO - 'opt_config_files': (), 09:48:33 INFO - 'pip_index': False, 09:48:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:33 INFO - 'cmd': ('bash', 09:48:33 INFO - '-c', 09:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:33 INFO - 'enabled': True, 09:48:33 INFO - 'halt_on_failure': False, 09:48:33 INFO - 'name': 'check_screen_resolution'},), 09:48:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:33 INFO - 'cmd': ('bash', 09:48:33 INFO - '-c', 09:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:33 INFO - 'enabled': True, 09:48:33 INFO - 'halt_on_failure': False, 09:48:33 INFO - 'name': 'check_screen_resolution'},), 09:48:33 INFO - 'run_cmd_checks_enabled': True, 09:48:33 INFO - 'sps_profile': False, 09:48:33 INFO - 'sps_profile_interval': 0, 09:48:33 INFO - 'suite': 'dromaeojs', 09:48:33 INFO - 'system_bits': '32', 09:48:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:33 INFO - 'title': 't-yosemite-r7-0144', 09:48:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:33 INFO - 'use_talos_json': True, 09:48:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:33 INFO - 'work_dir': 'build'} 09:48:33 INFO - ##### 09:48:33 INFO - ##### Running clobber step. 09:48:33 INFO - ##### 09:48:33 INFO - Running pre-action listener: _resource_record_pre_action 09:48:33 INFO - Running main action method: clobber 09:48:33 INFO - rmtree: /builds/slave/test/build 09:48:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:33 INFO - Running post-action listener: _resource_record_post_action 09:48:33 INFO - ##### 09:48:33 INFO - ##### Running read-buildbot-config step. 09:48:33 INFO - ##### 09:48:33 INFO - Running pre-action listener: _resource_record_pre_action 09:48:33 INFO - Running main action method: read_buildbot_config 09:48:33 INFO - Using buildbot properties: 09:48:33 INFO - { 09:48:33 INFO - "project": "", 09:48:33 INFO - "product": "firefox", 09:48:33 INFO - "script_repo_revision": "production", 09:48:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:48:33 INFO - "repository": "", 09:48:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:48:33 INFO - "buildid": "20160426084357", 09:48:33 INFO - "pgo_build": "False", 09:48:33 INFO - "basedir": "/builds/slave/test", 09:48:33 INFO - "buildnumber": 670, 09:48:33 INFO - "slavename": "t-yosemite-r7-0144", 09:48:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:48:33 INFO - "platform": "yosemite_r7", 09:48:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:48:33 INFO - "branch": "fx-team", 09:48:33 INFO - "repo_path": "integration/fx-team", 09:48:33 INFO - "revision": "8c55d8beba757967f6f5f7ff386499e8c6823c11", 09:48:33 INFO - "stage_platform": "macosx64", 09:48:33 INFO - "builduid": "f8ee86fbc5814290997e348edec02a2b", 09:48:33 INFO - "slavebuilddir": "test" 09:48:33 INFO - } 09:48:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 09:48:33 INFO - Running post-action listener: _resource_record_post_action 09:48:33 INFO - ##### 09:48:33 INFO - ##### Running download-and-extract step. 09:48:33 INFO - ##### 09:48:33 INFO - Running pre-action listener: _resource_record_pre_action 09:48:33 INFO - Running main action method: download_and_extract 09:48:33 INFO - mkdir: /builds/slave/test/build/tests 09:48: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')]} 09:48:33 INFO - https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:35 INFO - Downloaded 1199 bytes. 09:48:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 09:48:35 INFO - Using the following test package requirements: 09:48:35 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:48:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 09:48:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 09:48:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'jsshell-mac.zip'], 09:48:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 09:48:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:48:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 09:48:35 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 09:48:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 09:48:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:48:35 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 09:48:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:35 INFO - https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:36 INFO - Downloaded 18114140 bytes. 09:48:36 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'] 09:48:36 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 09:48:39 INFO - Return code: 0 09:48:39 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 09:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:39 INFO - https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:41 INFO - Downloaded 18114140 bytes. 09:48:41 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'] 09:48:41 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 09:48:45 INFO - Return code: 0 09:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:45 INFO - https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:46 INFO - Downloaded 10840145 bytes. 09:48:46 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'] 09:48:46 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 09:48:46 INFO - Return code: 0 09:48: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')]} 09:48:46 INFO - https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 09:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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 09:48:49 INFO - Downloaded 110129208 bytes. 09:48:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:48:49 INFO - mkdir: /builds/slave/test/properties 09:48:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:49 INFO - Contents: 09:48:49 INFO - build_url:https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:48:50 INFO - Running post-action listener: _resource_record_post_action 09:48:50 INFO - Running post-action listener: set_extra_try_arguments 09:48:50 INFO - ##### 09:48:50 INFO - ##### Running populate-webroot step. 09:48:50 INFO - ##### 09:48:50 INFO - Running pre-action listener: _resource_record_pre_action 09:48:50 INFO - Running main action method: populate_webroot 09:48:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:50 INFO - '--tppagecycles', 09:48:50 INFO - '7'], 09:48:50 INFO - 'tests': ['tsvgm']}}, 09:48:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['damp', 'tps']}, 09:48:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'tests': ['damp', 'tps']}, 09:48:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['dromaeo_dom']}, 09:48:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['a11yr', 09:48:50 INFO - 'ts_paint', 09:48:50 INFO - 'tpaint', 09:48:50 INFO - 'sessionrestore', 09:48:50 INFO - 'sessionrestore_no_auto_restore', 09:48:50 INFO - 'tabpaint']}, 09:48:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['tsvgx', 09:48:50 INFO - 'tsvgr_opacity', 09:48:50 INFO - 'tart', 09:48:50 INFO - 'tscrollx', 09:48:50 INFO - 'cart']}, 09:48:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:50 INFO - 'tsvgr_opacity', 09:48:50 INFO - 'tart', 09:48:50 INFO - 'tscrollx', 09:48:50 INFO - 'cart']}, 09:48:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'talos_options': ['--disable-e10s'], 09:48:50 INFO - 'tests': ['tp5o']}, 09:48:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'tests': ['tp5o']}, 09:48:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'talos_options': ['--disable-e10s', 09:48:50 INFO - '--xperf_path', 09:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:50 INFO - 'tests': ['tp5n']}, 09:48:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:50 INFO - 'talos_options': ['--xperf_path', 09:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:50 INFO - 'tests': ['tp5n']}}, 09:48:50 INFO - 'talos.zip': {'path': '', 09:48:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:50 INFO - Running post-action listener: _resource_record_post_action 09:48:50 INFO - ##### 09:48:50 INFO - ##### Running create-virtualenv step. 09:48:50 INFO - ##### 09:48:50 INFO - Running pre-action listener: _resource_record_pre_action 09:48:50 INFO - Running main action method: create_virtualenv 09:48:50 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:50 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 09:48:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:50 INFO - Using real prefix '/tools/python27' 09:48:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:54 INFO - Installing pip.................done. 09:48:54 INFO - Return code: 0 09:48:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:54 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:48:54 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 09:48:54 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 09:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:54 INFO - 'HOME': '/Users/cltbld', 09:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:54 INFO - 'LOGNAME': 'cltbld', 09:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:54 INFO - 'MOZ_NO_REMOTE': '1', 09:48:54 INFO - 'NO_EM_RESTART': '1', 09:48:54 INFO - 'PAGER': '/bin/cat', 09:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:54 INFO - 'PWD': '/builds/slave/test', 09:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:54 INFO - 'SHELL': '/bin/bash', 09:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:48:54 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:54 INFO - 'USER': 'cltbld', 09:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:54 INFO - 'XPC_FLAGS': '0x0', 09:48:54 INFO - 'XPC_SERVICE_NAME': '0', 09:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:54 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 09:48:54 INFO - Cleaning up... 09:48:54 INFO - Return code: 0 09:48:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:54 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:48:54 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 09:48:54 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 09:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:54 INFO - 'HOME': '/Users/cltbld', 09:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:54 INFO - 'LOGNAME': 'cltbld', 09:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:54 INFO - 'MOZ_NO_REMOTE': '1', 09:48:54 INFO - 'NO_EM_RESTART': '1', 09:48:54 INFO - 'PAGER': '/bin/cat', 09:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:54 INFO - 'PWD': '/builds/slave/test', 09:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:54 INFO - 'SHELL': '/bin/bash', 09:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:48:54 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:54 INFO - 'USER': 'cltbld', 09:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:54 INFO - 'XPC_FLAGS': '0x0', 09:48:54 INFO - 'XPC_SERVICE_NAME': '0', 09:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:54 INFO - Downloading/unpacking psutil>=0.7.1 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:54 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 09:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:57 INFO - Installing collected packages: psutil 09:48:57 INFO - Running setup.py install for psutil 09:48:57 INFO - building 'psutil._psutil_osx' extension 09:48:57 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 09:48:57 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 09:48:57 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 09:48:58 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 09:48:58 INFO - building 'psutil._psutil_posix' extension 09:48:58 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 09:48:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:48:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:48:58 INFO - ^ 09:48:58 INFO - 1 warning generated. 09:48:58 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 09:48:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:58 INFO - Successfully installed psutil 09:48:58 INFO - Cleaning up... 09:48:58 INFO - Return code: 0 09:48:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:58 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')]} 09:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 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')]} 09:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:48:58 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 09:48:58 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 09:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:58 INFO - 'HOME': '/Users/cltbld', 09:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:58 INFO - 'LOGNAME': 'cltbld', 09:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:58 INFO - 'MOZ_NO_REMOTE': '1', 09:48:58 INFO - 'NO_EM_RESTART': '1', 09:48:58 INFO - 'PAGER': '/bin/cat', 09:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:58 INFO - 'PWD': '/builds/slave/test', 09:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:58 INFO - 'SHELL': '/bin/bash', 09:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:48:58 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:58 INFO - 'USER': 'cltbld', 09:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:58 INFO - 'XPC_FLAGS': '0x0', 09:48:58 INFO - 'XPC_SERVICE_NAME': '0', 09:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:48:58 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 09:49:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:01 INFO - Installing collected packages: mozsystemmonitor 09:49:01 INFO - Running setup.py install for mozsystemmonitor 09:49:01 INFO - Successfully installed mozsystemmonitor 09:49:01 INFO - Cleaning up... 09:49:01 INFO - Return code: 0 09:49:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:01 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 09:49:01 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 09:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:01 INFO - 'HOME': '/Users/cltbld', 09:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:01 INFO - 'LOGNAME': 'cltbld', 09:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:01 INFO - 'MOZ_NO_REMOTE': '1', 09:49:01 INFO - 'NO_EM_RESTART': '1', 09:49:01 INFO - 'PAGER': '/bin/cat', 09:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:01 INFO - 'PWD': '/builds/slave/test', 09:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:01 INFO - 'SHELL': '/bin/bash', 09:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:01 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:01 INFO - 'USER': 'cltbld', 09:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:01 INFO - 'XPC_FLAGS': '0x0', 09:49:01 INFO - 'XPC_SERVICE_NAME': '0', 09:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:01 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 09:49:01 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 09:49:01 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 09:49:01 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 09:49:01 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 09:49:01 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 09:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:04 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 09:49:05 INFO - Downloading docopt-0.6.1.tar.gz 09:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:05 INFO - Running setup.py install for blobuploader 09:49:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:05 INFO - Running setup.py install for requests 09:49:05 INFO - Running setup.py install for docopt 09:49:05 INFO - Successfully installed blobuploader requests docopt 09:49:05 INFO - Cleaning up... 09:49:06 INFO - Return code: 0 09:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:06 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')]} 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:06 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')]} 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:06 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:06 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 09:49:06 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 09:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:06 INFO - 'HOME': '/Users/cltbld', 09:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:06 INFO - 'LOGNAME': 'cltbld', 09:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:06 INFO - 'MOZ_NO_REMOTE': '1', 09:49:06 INFO - 'NO_EM_RESTART': '1', 09:49:06 INFO - 'PAGER': '/bin/cat', 09:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:06 INFO - 'PWD': '/builds/slave/test', 09:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:06 INFO - 'SHELL': '/bin/bash', 09:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:06 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:06 INFO - 'USER': 'cltbld', 09:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:06 INFO - 'XPC_FLAGS': '0x0', 09:49:06 INFO - 'XPC_SERVICE_NAME': '0', 09:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-LaLveT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-aE7tJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-fd_mR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-GMoEBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-RTiwS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-W1Xiwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:06 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pW11Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-DFkuyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Lr38kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-HeLFD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3npSZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vvoie8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XN9Aub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-UufgoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Nsq6LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-_DCvW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:07 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-AHcpCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:08 INFO - Running setup.py install for manifestparser 09:49:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:08 INFO - Running setup.py install for mozcrash 09:49:08 INFO - Running setup.py install for mozdebug 09:49:08 INFO - Running setup.py install for mozdevice 09:49:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:08 INFO - Running setup.py install for mozfile 09:49:08 INFO - Running setup.py install for mozhttpd 09:49:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:08 INFO - Running setup.py install for mozinfo 09:49:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Running setup.py install for mozInstall 09:49:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Running setup.py install for mozleak 09:49:09 INFO - Running setup.py install for mozlog 09:49:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Running setup.py install for moznetwork 09:49:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:09 INFO - Running setup.py install for mozprocess 09:49:09 INFO - Running setup.py install for mozprofile 09:49:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:10 INFO - Running setup.py install for mozrunner 09:49:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:10 INFO - Running setup.py install for mozscreenshot 09:49:10 INFO - Running setup.py install for moztest 09:49:10 INFO - Running setup.py install for mozversion 09:49:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:10 INFO - Cleaning up... 09:49:10 INFO - Return code: 0 09:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:10 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:10 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 09:49:10 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 09:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:10 INFO - 'HOME': '/Users/cltbld', 09:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:10 INFO - 'LOGNAME': 'cltbld', 09:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:10 INFO - 'MOZ_NO_REMOTE': '1', 09:49:10 INFO - 'NO_EM_RESTART': '1', 09:49:10 INFO - 'PAGER': '/bin/cat', 09:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:10 INFO - 'PWD': '/builds/slave/test', 09:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:10 INFO - 'SHELL': '/bin/bash', 09:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:10 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:10 INFO - 'USER': 'cltbld', 09:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:10 INFO - 'XPC_FLAGS': '0x0', 09:49:10 INFO - 'XPC_SERVICE_NAME': '0', 09:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:10 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vNdg2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-s_XN20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-8SsuS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-b_EdmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-W8RkND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-KkE5Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-96_w6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-y6gJka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-7pgmB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:11 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)) 09:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:11 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cbrCaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-au1xDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-XJs5z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-4N2mtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-jF66mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ALNOY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-NqmQs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:12 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)) 09:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:12 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-68Nr9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:12 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)) 09:49:12 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)) 09:49:12 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)) 09:49:12 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)) 09:49:12 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)) 09:49:12 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)) 09:49:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:15 INFO - Downloading blessings-1.6.tar.gz 09:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:15 INFO - Installing collected packages: blessings 09:49:15 INFO - Running setup.py install for blessings 09:49:15 INFO - Successfully installed blessings 09:49:15 INFO - Cleaning up... 09:49:15 INFO - Return code: 0 09:49:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:15 INFO - Reading from file tmpfile_stdout 09:49:15 INFO - Current package versions: 09:49:15 INFO - blessings == 1.6 09:49:15 INFO - blobuploader == 1.2.4 09:49:15 INFO - docopt == 0.6.1 09:49:15 INFO - manifestparser == 1.1 09:49:15 INFO - mozInstall == 1.12 09:49:15 INFO - mozcrash == 0.17 09:49:15 INFO - mozdebug == 0.1 09:49:15 INFO - mozdevice == 0.48 09:49:15 INFO - mozfile == 1.2 09:49:15 INFO - mozhttpd == 0.7 09:49:15 INFO - mozinfo == 0.9 09:49:15 INFO - mozleak == 0.1 09:49:15 INFO - mozlog == 3.1 09:49:15 INFO - moznetwork == 0.27 09:49:15 INFO - mozprocess == 0.22 09:49:15 INFO - mozprofile == 0.28 09:49:15 INFO - mozrunner == 6.11 09:49:15 INFO - mozscreenshot == 0.1 09:49:15 INFO - mozsystemmonitor == 0.0 09:49:15 INFO - moztest == 0.7 09:49:15 INFO - mozversion == 1.4 09:49:15 INFO - psutil == 3.1.1 09:49:15 INFO - requests == 1.2.3 09:49:15 INFO - wsgiref == 0.1.2 09:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:15 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 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:15 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 09:49:15 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 09:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:15 INFO - 'HOME': '/Users/cltbld', 09:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:15 INFO - 'LOGNAME': 'cltbld', 09:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:15 INFO - 'MOZ_NO_REMOTE': '1', 09:49:15 INFO - 'NO_EM_RESTART': '1', 09:49:15 INFO - 'PAGER': '/bin/cat', 09:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:15 INFO - 'PWD': '/builds/slave/test', 09:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:15 INFO - 'SHELL': '/bin/bash', 09:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:15 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:15 INFO - 'USER': 'cltbld', 09:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:15 INFO - 'XPC_FLAGS': '0x0', 09:49:15 INFO - 'XPC_SERVICE_NAME': '0', 09:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 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)) 09:49:16 INFO - Cleaning up... 09:49:16 INFO - Return code: 0 09:49:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:16 INFO - 'HOME': '/Users/cltbld', 09:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:16 INFO - 'LOGNAME': 'cltbld', 09:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:16 INFO - 'MOZ_NO_REMOTE': '1', 09:49:16 INFO - 'NO_EM_RESTART': '1', 09:49:16 INFO - 'PAGER': '/bin/cat', 09:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:16 INFO - 'PWD': '/builds/slave/test', 09:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:16 INFO - 'SHELL': '/bin/bash', 09:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:16 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:16 INFO - 'USER': 'cltbld', 09:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:16 INFO - 'XPC_FLAGS': '0x0', 09:49:16 INFO - 'XPC_SERVICE_NAME': '0', 09:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:16 INFO - Downloading/unpacking jsonschema 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:18 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 09:49:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:19 INFO - warning: no files found matching '*.txt' 09:49:19 INFO - no previously-included directories found matching 'build' 09:49:19 INFO - no previously-included directories found matching 'dist' 09:49:19 INFO - no previously-included directories found matching '.git*' 09:49:19 INFO - Installing collected packages: jsonschema, functools32 09:49:19 INFO - Running setup.py install for functools32 09:49:19 INFO - warning: no files found matching '*.txt' 09:49:19 INFO - no previously-included directories found matching 'build' 09:49:19 INFO - no previously-included directories found matching 'dist' 09:49:19 INFO - no previously-included directories found matching '.git*' 09:49:19 INFO - Successfully installed jsonschema functools32 09:49:19 INFO - Cleaning up... 09:49:19 INFO - Return code: 0 09:49:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101cbea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef5acc5390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, '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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 09:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:19 INFO - 'HOME': '/Users/cltbld', 09:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:19 INFO - 'LOGNAME': 'cltbld', 09:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:19 INFO - 'MOZ_NO_REMOTE': '1', 09:49:19 INFO - 'NO_EM_RESTART': '1', 09:49:19 INFO - 'PAGER': '/bin/cat', 09:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:19 INFO - 'PWD': '/builds/slave/test', 09:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:19 INFO - 'SHELL': '/bin/bash', 09:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:19 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:19 INFO - 'USER': 'cltbld', 09:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:19 INFO - 'XPC_FLAGS': '0x0', 09:49:19 INFO - 'XPC_SERVICE_NAME': '0', 09:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:19 INFO - Downloading/unpacking flake8 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:23 INFO - no previously-included directories found matching 'docs/_build' 09:49:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:23 INFO - Running setup.py install for pep8 09:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:23 INFO - no previously-included directories found matching 'docs/_build' 09:49:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:49:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:23 INFO - Cleaning up... 09:49:23 INFO - Return code: 0 09:49:23 INFO - Running post-action listener: _resource_record_post_action 09:49:23 INFO - Running post-action listener: _start_resource_monitoring 09:49:23 INFO - Starting resource monitoring. 09:49:23 INFO - ##### 09:49:23 INFO - ##### Running install step. 09:49:23 INFO - ##### 09:49:23 INFO - Running pre-action listener: _resource_record_pre_action 09:49:23 INFO - Running main action method: install 09:49:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:24 INFO - Reading from file tmpfile_stdout 09:49:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:24 INFO - Reading from file tmpfile_stdout 09:49:24 INFO - Output received: 09:49:24 INFO - Usage: mozinstall [options] installer 09:49:24 INFO - Options: 09:49:24 INFO - -h, --help show this help message and exit 09:49:24 INFO - -d DEST, --destination=DEST 09:49:24 INFO - Directory to install application into. [default: 09:49:24 INFO - "/builds/slave/test"] 09:49:24 INFO - --app=APP Application being installed. [default: firefox] 09:49:24 INFO - mkdir: /builds/slave/test/build/application 09:49:24 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'] 09:49:24 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 09:49:58 INFO - Reading from file tmpfile_stdout 09:49:58 INFO - Output received: 09:49:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:49:58 INFO - Running post-action listener: _resource_record_post_action 09:49:58 INFO - ##### 09:49:58 INFO - ##### Running run-tests step. 09:49:58 INFO - ##### 09:49:58 INFO - Running pre-action listener: _resource_record_pre_action 09:49:58 INFO - Running main action method: run_tests 09:49:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:58 INFO - 2016-04-26 09:49:58.231 screenresolution[1954:12935] starting screenresolution argv=screenresolution get 09:49:58 INFO - 2016-04-26 09:49:58.233 screenresolution[1954:12935] Display 0: 1600x1200x32@60 09:49:58 INFO - 2016-04-26 09:49:58.239 screenresolution[1955:12937] starting screenresolution argv=screenresolution list 09:49:58 INFO - Available Modes on Display 0 09:49:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:58 INFO - Intel Iris: 09:49:58 INFO - Chipset Model: Intel Iris 09:49:58 INFO - Type: GPU 09:49:58 INFO - Bus: Built-In 09:49:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:58 INFO - Vendor: Intel (0x8086) 09:49:58 INFO - Device ID: 0x0a2e 09:49:58 INFO - Revision ID: 0x0009 09:49:58 INFO - Displays: 09:49:58 INFO - Display: 09:49:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:58 INFO - Display Serial Number: 1600x1200 60 09:49:58 INFO - Main Display: Yes 09:49:58 INFO - Mirror: Off 09:49:58 INFO - Online: Yes 09:49:58 INFO - Rotation: Supported 09:49:58 INFO - Return code: 0 09:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:58 INFO - Python 2.7.3 09:49:58 INFO - Return code: 0 09:49:58 INFO - grabbing minidump binary from tooltool 09:49:58 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')]} 09:49:58 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 0x101b5de00>, '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 0x101986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101b58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:58 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 09:49:58 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 09:49:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:58 INFO - Return code: 0 09:49:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:49:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:49:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:49:59 INFO - Return code: 0 09:49:59 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/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 09:49:59 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/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 09:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PU9hSa5Wzg/Render', 09:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:59 INFO - 'HOME': '/Users/cltbld', 09:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:59 INFO - 'LOGNAME': 'cltbld', 09:49:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:59 INFO - 'MOZ_NO_REMOTE': '1', 09:49:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:59 INFO - 'NO_EM_RESTART': '1', 09:49:59 INFO - 'PAGER': '/bin/cat', 09:49:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:59 INFO - 'PWD': '/builds/slave/test', 09:49:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:59 INFO - 'SHELL': '/bin/bash', 09:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9xDLjwmyfG/Listeners', 09:49:59 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 09:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:59 INFO - 'USER': 'cltbld', 09:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:59 INFO - 'XPC_FLAGS': '0x0', 09:49:59 INFO - 'XPC_SERVICE_NAME': '0', 09:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:59 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/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 09:49:59 INFO - mozversion application_buildid: 20160426084357 09:49:59 INFO - mozversion application_changeset: 8c55d8beba757967f6f5f7ff386499e8c6823c11 09:49:59 INFO - mozversion application_display_name: Nightly 09:49:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:59 INFO - mozversion application_name: Firefox 09:49:59 INFO - mozversion application_remotingname: firefox 09:49:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:49:59 INFO - mozversion application_vendor: Mozilla 09:49:59 INFO - mozversion application_version: 49.0a1 09:49:59 INFO - mozversion platform_buildid: 20160426084357 09:49:59 INFO - mozversion platform_changeset: 8c55d8beba757967f6f5f7ff386499e8c6823c11 09:49:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:49:59 INFO - mozversion platform_version: 49.0a1 09:49:59 INFO - using testdate: 1461689399 09:49:59 INFO - actual date: 1461689399 09:49:59 INFO - starting webserver on 'localhost:49515' 09:49:59 INFO - SUITE-START | Running 2 tests 09:49:59 INFO - TEST-START | dromaeo_css 09:49:59 INFO - operating with platform_type : mac_ 09:49:59 INFO - Initialising browser for dromaeo_css test... 09:49:59 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpOervNC/profile http://localhost:49515/getInfo.html) 09:50:02 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 09:50:02 INFO - PROCESS | 1973 | colorDepth:24 09:50:02 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 09:50:02 INFO - PROCESS | 1973 | __metrics 09:50:02 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:50:02 ERROR - PROCESS | 1973 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:50:02 INFO - TEST-INFO | 1973: exit 0 09:50:02 INFO - Browser initialized. 09:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:02 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpOervNC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:14 INFO - PROCESS | 1975 | RSS: Main: 239484928 09:50:14 INFO - PROCESS | 1975 | 09:51:06 INFO - PROCESS | 1975 | 1461689466181 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] 09:53:16 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49515/tests/dromaeo/cssquery-ext.html) 09:53:18 INFO - PROCESS | 1975 | RSS: Main: 385060864 09:53:18 INFO - PROCESS | 1975 | 09:56:21 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-ext.html (next: http://localhost:49515/tests/dromaeo/cssquery-jquery.html) 09:56:21 INFO - PROCESS | 1975 | RSS: Main: 378351616 09:56:21 INFO - PROCESS | 1975 | 09:59:23 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49515/tests/dromaeo/cssquery-mootools.html) 09:59:24 INFO - PROCESS | 1975 | RSS: Main: 378904576 09:59:24 INFO - PROCESS | 1975 | 10:02:26 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49515/tests/dromaeo/cssquery-prototype.html) 10:02:27 INFO - PROCESS | 1975 | RSS: Main: 377991168 10:02:27 INFO - PROCESS | 1975 | 10:05:30 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49515/tests/dromaeo/cssquery-yui.html) 10:05:31 INFO - PROCESS | 1975 | RSS: Main: 346484736 10:05:31 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-yui.html (next: http://localhost:49515/tests/dromaeo/cssquery-dojo.html) 10:08:34 INFO - PROCESS | 1975 | RSS: Main: 386318336 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | __start_tp_report 10:08:34 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 10:08:34 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 10:08:34 INFO - PROCESS | 1975 | |i|pagename|runs| 10:08:34 INFO - PROCESS | 1975 | |0;dojo.html;2672.144913627639;3154.447971604969;3415.1120708615767;3457.464093065574;3462.1690794209367;4677.368555245041;5666.631668941516;5716.3426205986325;5725.828225153246;5737.6557406555585;5634.239377684022;5691.686957217351;5703.800366987156;5711.343195532515;5722.7424765885535;5122.308488354071;5166.974165129169;5209.32278803755;5214.0875346814155;5261.421243663194;5212.687238765686;5251.212318152269;5251.975864706384;5266.552343050846;5268.262443257947;4165.520965089023;5199.376074871002;5230.764615592308;5242.606804489678;5251.291075704769;5214.348206474172;5250.501202385767;5251.081060814342;5267.209918512215;5321.600879934021;5011.84964451067;5066.518680725325;5118.92784036558;5183.818566350197;5193.324867767166;4747.264174053027;4920.384951881015;5537.058700021006;5542.91685624716;5553.0837411827;6197.0704394340755;6252.499800015988;6253.906191407133;6256.843578910518;6266.3420340864;5013.448520662724;6186.969065154691;6194.256689197326;6324.494040476751;6327.8734425311695;5771.6248443851855;5809.128630705343;5817.94182058174;5823.417658234185;5874.412558744134;6242.937570624235;6259.655718935411;6270.811875643738;6279.058141278845;6286.591371560834;5941.079132734433;6067.848303792441;6082.36135205797;6108.938910610837;6160.229971253593;6192.938070619326;6208.937910620926;6215.627062376272;6223.782167624111;6227.346128656426;6150.261968563801;6172.69136543171;6191.380861913863;6213.254409470893;6223.190985171989;6094.421030002142;6164.137020817089;6168.537359698041;6211.751529938751;6245.843853903689;4883.218685010382;4907.975460122748;4911.18965370717;4919.729414882144;4922.064807686528;4469.642428605704;4484.887877803016;4499.910001800011;4500.054988452462;4505.819767209275;5655.3779084300695;5663.320401551758;5664.235328230719;5671.546276297886;5673.978683836866;5106.310648062538;6110.419510146529;6208.00671892495;6209.751609935552;6232.56372053961;5741.368449470555;5747.827565173052;5748.45389687979;5776.191333213354;5777.7977770777825;5404.189371594292;5419.701916394557;5421.2139239810795;5428.104362780176;5430.348358196962;6186.319504854462;6258.405451482102;6304.243490781136;6353.745850166034;6369.713362898773;5579.302587176603;5872.354041055395;6188.350223226496;6214.40963108504;6220.222472190976;6191.504679625709;6313.033647695745;6357.491400688026;6373.267074286517;6476.190476190476;5074.771635276347;6109.131392048963;6183.659898705614;6206.255249370104;6210.130581718653;6172.506199503939;6179.84550386226;6186.226721659793;6211.596246243979;6227.346128656426;4669.649776266726;5947.434993675594;6132.233470816148;6145.907811382922;6147.692615369124;6061.515078793598;6074.696265186634;6088.726007329769;6091.695415229309;6128.448439640454;5233.874716935877;5888.882222355443;5925.377835327228;5942.168096466585;5955.225820643289;5790.536757059341;6081.057436097412;6105.914670190187;6108.786192483241;6112.816615501542;5977.760889564369;5979.073243647242;5981.611195272293;5985.952458319864;5997.880042399215 10:08:34 INFO - PROCESS | 1975 | |1;ext.html;483.96128309735224;507.946665600112;509.97195154266524;545.405507996284;561.8005608009157;24070;30146.397072058575;36735.44896826547;37811.621883781154;37871;39417.21165576687;40016.59983400165;40106.59893401065;40155.39766903499;40166.59416920409;9266.953665231682;9475;9490.52547372632;9506.334556581041;9508.429494230368;8388.37087218461;8576.871346929769;8579.056303806576;8590.441621294596;8608.956955215215;11253.774924501546;11521.884781152206;11529.250598711098;11533.365664888428;11538.596149134783;11276.887231127706;11419.657410277705;11441.885581144164;11455.484503197376;11481.425928703573;8364.37267204962;11027.0075693188;11141;11271.492782824711;11317.943410282896;36780.632193677986;37289.62710372916;37336;37348.81325593355;37356.62643373559;3168.7940283881476;3226.3386005868742;3273.165342837585;3421.9315613687586;3758.924821503582;26292.21123366302;27694.861525692242;27963.860180698965;28230.87076516937;28347.858260708563;2694.9865250673815;2707.878145483458;2711.959320610192;2754.0911499205213;2917.679055303915;288870;293794;294179.52910235524;294898;295182;57943.710281449166;58113.709431452575;58728.41271587315;58748.82502349929;58823.70588147118;61351.71751813448;61527.077093843625;61549;61653;61672.691636542426;15857.603559911095;16116.355345786038;16165.919170404073;16482.34070637185;16969.745453818203;11409;12591.6778738233;13116.540921067908;13121.015923805753;13123.212607243597;14334.283285835667;15494.690106197813;15937.601559961095;16813.747793783103;18236;7489;7670.7315243966195;7730.072391313079;7733.49732267412;7741.303282704471;985.610683779903;1013.2603199664286;1022.4734261855151;1072.953869976782;1162.9649611845296;27290.908363665232;27678.861605692244;27694;27764.583531247048;27910;1092.9672109836717;1153.763478486908;1165.7817580628264;1174.236746115032;1211.2611307102661;14569;14786.852131478547;14826.851731482762;14959.476418325525;15032;461881.6905915449;462703;469495;470218;470623;56353;56925.71537142288;57011.71494142503;57014;57139.428605714245;1292.9612111636666;1360.693843885118;1438.4749566408395;1481.5111013365563;1493.171289934097;27527.86236068807;27654.585181221897;28197.295067622654;28201.858990704914;28437.573436398055;44268.778656106515;44431.66704998855;44844.775776120914;44908.99999999869;44929;258951;259656;259715;266512;293016.8142433638;21805.78194218101;24238;24850.130245441323;25011.624825627267;25026;40853.38719919144;41350.79324603358;41725.37411938884;41788;42525.36211956885;33549.2124410331;35782;35900.461493077106;36689.26621467609;37163.628363716016;34937;35175.82412087923;35367.64632353746;36101.45847812337;36177.63822361848;35577.46633800547;35695.10762230965;35926.64073359233;36142;36593;24972;29997.100086997423;31764;31861.840690796398;31878;22742.545149097255;23197.536049279257;23307.76692233056;23553.646695299925;23796.643050354603 10:08:34 INFO - PROCESS | 1975 | |2;jquery.html;354.4293687163666;394.1407731146101;395.7684754418665;404.1895998522961;406.65434380776344;15415.768763468543;19825.107870145843;20537.178512859486;20590;20640.071196796143;19708.408747737554;20283.797162028375;20314.288999885008;20455.795442045575;20893.791062089374;5192.55863251624;5723.570732195081;5934.228550288456;5950.494207992326;5950.523958083343;6021.367756385582;6042.879142417149;6067.120267561201;6067.605605635619;6080.30076541199;5727.3699893011735;5925.814837032589;5945.108233764927;5952;5958.79144229952;5754.165645981351;5926.111083337512;5945.940540594604;5948.048312270016;5951.49412299955;4705.223638099709;4958.900821983576;5121.078205922932;5181.689098654093;5221.477852214748;24317.513649726905;24820.875895620586;25203.11789087373;25276.241712748462;25357.873210634014;2106.252280440452;2181.1057466438842;2212.6459766437456;2258.683784270187;2391.712994440661;11238.775224495464;14832.332545035499;14853.183074930874;15149.469768558047;15244;1572.4417831669707;1590.7136715391225;1617.4015614222694;1767.9734803977951;1785.6875046866746;99739;103048.48475757649;103229.483852581;104153.47923260335;105822;9523.28575356851;10377.429241391645;10634.255602107933;10861.456927153611;10999.765090440078;10996.340219586851;12885;13630.93184534071;13645.43077546075;13672.726545469035;8333.6666533338;8446.831063378699;8579.613917373734;8681.088485709037;8686.261667758185;7252.963735181396;8550.187732165434;8567.485950842969;8572.35707321941;8675.739727808175;5346.743515273907;6540.542162048706;6555.573887697285;6557.803265901935;6563;1577.242923396776;1909.8185672361103;1910.6751852185162;1932.603816217672;1941.6990366493217;903.4488961733338;942.9292803039799;982.9017098290257;1019.3425240719695;1037.896210378971;19350.61298774045;19491.805081948998;20146.597068058556;20684.58630827375;20688.793112068986;961.3606951377255;970.1075010989906;997.6607953295769;999.6801023672355;1015.3653966271081;10677.57289708403;11288.04051655602;11314.094872410187;11326.093912486982;11330.490127944262;539700;544932;550880.4207621333;558096;558442;61141;79762.40475190464;98791;102717;103036;1008.6469735592484;1039.1686650679426;1040.5577629507277;1042.155853758458;1044.6343779677204;17879.553011174823;17932.462026139237;18167;18298.634027319644;18608.06959651985;39858.60141398549;40682;43779;46090;48242;65163.69672606426;65935;66014.33985660083;66202;67161;7453.366463850633;7570.81072973158;7896.7236146734585;7976.7208147714555;8365.372597055368;8562.159135785836;11822.40887955616;11840.348780817138;12151.817722734342;12262.08034397406;8502.489850608983;10393.37639741618;10404.895951040393;10709.518071686949;10765.89234107649;10403.375797452178;10465.47672616351;10526.947365263431;10564.154867610727;10706.250562460553;10542.894571054192;10704;10843.403612801372;10976.396298203676;11019.118470522499;7966.123726389977;8043.356531477585;8053;8328.708495202638;8414.87377689323;10541.789164216827;10566.577336906745;10700.571977120828;10791.946040269748;10940.945295273472 10:08:34 INFO - PROCESS | 1975 | |3;mootools.html;1366.863313668634;1613.4514265149846;1627.0969611865414;1899.6105798311348;2034.9796502034985;7852.882206766896;8618.439801412904;8848.646054157842;8860.734177974671;8879.822403551932;8486.405951583392;8701.695440659578;8705.65177392905;8707.73876783696;8733.956330218356;2127.4255950893325;2202.119152339061;2202.6255536558742;2396.149366974729;2438.548868459332;2194.9780502194935;2320.9883950580224;2402.699662542182;2490.6762120924254;2503.3115893129443;2411.9758802411925;2438.5610590093775;2449.130558651671;2451.4361696809747;2456.1771806444863;2113.260358874397;2418.3833122553724;2433.415980164765;2433.5741245282184;2436.281297017384;2328.52265285616;2406.422458609921;2407;2413.9861258271567;2415.553122672311;8576.571171441465;8678.392512524126;8684.869726954037;8688.348373871922;8697.95651021741;5045.974770126162;5301.1783173608155;5329.706866122362;5348.144296912515;5361.705106219157;3374.190194353362;3414.402479566066;3476.8435420406145;3598.460230965376;3604.2611264690677;847.9152084791533;933.9533023348873;1041.0058394233488;1048.2505008918583;1049.6378749331468;11803.704907377385;11825.172237943347;11851.348175850238;11865;11870.347130907796;4342.023044814891;4606;4655.255159174516;4722.598579120745;4860.465348811628;10096.343737657176;10133.391996480235;10153.695389138338;10160.4919754012;10167.694969150938;5313.229581710631;5362.302900622894;5372.62391632582;5408.594355423359;5410.296661433988;4210.915781684349;4859.684120532224;4918.508149185124;4955.4548999610015;4966.304717339575;3860.2665493556133;3866.994581408854;3870.4581358609817;3891.416287556889;3975.940360894589;1220.7741567809983;1221.4564518789055;1233.272369302116;1236.5610208376077;1238.0095923261356;819.7049062337554;882.6557642519423;895.9731208063769;924.4083786376724;938.0853667673963;5666.518345940559;5695.45893140151;5849.912251316234;5897.439743224387;5916.23088998436;433.0343334364385;445.12755000199326;447.1838894018429;453.68922288232665;457.77340216593;3817.522809648794;3968.2857085724845;4044.6359827615656;4094.3449048152747;4139.275626765304;10504.842427363596;10711.732206694895;10763;10891;10899.945500272448;9404.576794044284;10016.949915250523;10813.405262710627;10857.891421085846;10874.347539147677;7952.602369881482;8020.51876887377;8090.757277281691;8262.958685206655;8270.007599088027;5343.438938911514;6011.90982135277;6050.606710563799;6096.116063170904;6124.234470691164;9513.66702165421;9617.71146865595;10001.749956251151;10020.69937901864;10153.898461015295;8938.46369217849;9681.080297371738;10264.973502649975;10277.434741089013;10329.96700329961;6108.328083910855;6892.414144797548;7555.622218888923;7557.2820582044615;7558.811029724301;8156.429049966446;8164.061132969547;8178.141295163922;8208.753737387888;8261.710840120568;7377.926220737724;7404.888926666212;7482.551046937201;7559.773206803805;7583.05211848519;6330.905036424365;7172.856542869218;7297.1973082961895;7361.319864378325;7361.779146625609;7053.188883278489;7132.144142702701;7138.678759455941;7159.749408770668;7164.713411463692;4680.274557443602;4905.552861905675;4939.185034469416;4967.230079337708;4978.6763860348965;4739.431268247832;4888.364512613338;4985.775640096277;4986.127427700066;5207.5833933286 10:08:34 INFO - PROCESS | 1975 | |4;prototype.html;314.9480335744602;315.45741324921136;321.10251846090176;324.32216667165625;326.6765901757258;4193.685473589478;4405.33919912013;5120.820771273002;5139.614528910332;5187.4034486034025;3776.811159442024;4064.8780536583877;5105.744712764365;5128.4871512848695;5151.871203219912;3809.8285577149095;3871.4835357018023;3883.3204189266908;3998.4402183694306;4003.799810009488;3604.4593311003428;3640.507391969293;3896.4739760132443;3958.247932892741;3960.2673505401594;3580.838862251192;3930.5479869815053;3945.7040721945827;3955.525336959569;3958.9802050989706;3688.7642639715727;3725.9008592465016;3740.3454395480817;3836.635519625645;3840.6927445804267;3088.3977624363256;3133.8746450141966;3430.8335166043667;3455.7926524408363;3490.336836001177;4048.7853643907006;4182.2890108681295;4896.143174944406;4922.16323225049;4977.925331120036;3573.874914377984;3771.9627102546747;4444.888877778049;4506.639468842484;4524.45706515217;3987.920241595181;5010.298558201855;5255.316808814868;5315.255864179018;5321.680699158062;3501.77238479498;3551.5915669698056;3616.8372423241017;3812.866549670748;3843.327417701919;4165.354370072643;4790.736509491977;5194.831162988336;5308.478472725463;5552.889422115552;3478.5825700915548;3550.899221241423;3871.19989205021;3873.767573945572;3914.6868250539887;3959.9604003959594;3976.204759048202;3979.7811120388656;3990.700697447703;3998.5001874765653;4469.374287599739;4484.663650226246;4540.79566419512;4541.137183935108;4609.400777898852;5143.965060614256;5354.357477102694;5382.542483888913;5396.271503347077;5414.566834653218;1339.914669117998;1428.557147284345;1431;1441.040185347926;1447.1751101872042;747.3386053342831;795.5028107432854;899.3344924755634;979.7893452907659;987.6691308411619;4061.481881233654;4619.676622636451;4960.975195124073;5004.774785134678;5177.430482646906;4897.253600995242;5221.825089354865;5413.323334583177;5593.74828132735;5610.998116007998;5039.4708555601865;5051.368578927634;5071.163258062452;5077.086124497552;5100.1074811907765;2396.7962723168375;3160.146760374686;3169.6037995250595;3170.365926814646;3183.8567264473154;5407.729613519308;6189;6216.595921265103;6238.563300569007;6288.213973253343;5489.945100549024;5592.161175823659;5930.347661757203;5986.898974202598;6141.692915354214;5015.799368025238;5453.536449401845;5510.008198524304;6255.906161407583;6334.208223972004;4752.429708434872;6031.155638210566;6035.336113027475;6041.154238406539;6066.241719785027;5457.799284157479;5964.970175149097;6000.309809467059;6031.788887388921;6077.179580756541;5455.8363249102595;5479.53423958968;6303.401176888188;6314.778982735582;6333.493320534439;3612.187257866959;3698.815059246973;4136.544980052252;4167.7702429200235;4167.874963751093;4980.754811297175;5493.917591236214;5543.8891222174525;5561.775289884079;5606.831795046155;4806.351142595705;4987.850364489072;5150.1502252127975;5443.673379597237;5450.836474905759;4688.859334219979;5052.418971818288;5390.460953904578;5410.161424979135;5420.214068960057;4194;5224.373075230997;5263.868403289948;5299.470052994824;5314.535789936472;4540.003597625551;4562.88592785183;4653.767311634472;4892.902141957212;5333.439908877854;4931.605471562195;5305.814296499604;5332.493413125747;5361.713188834729;5436.293281873332 10:08:34 INFO - PROCESS | 1975 | |5;yui.html;679.3817625960377;692.0000599134253;730.6346826586704;734.4198083514024;768.2547928509346;14559.417623295069;15213.84786152138;15219.16294603795;15220.847791522081;15228.61928451788;13600.04799664024;13707.72584548311;13749.450021999108;13764.38060287287;13790.448382064706;712.5973824788978;734.7685479074102;876.51791514667;886.769439945614;905.9048799876017;905.8233644439337;909.6315992023208;914.3553794574842;914.6981496106303;915.4004127296598;968.3995922528043;969.9660511882086;973.7176218896511;974.44456659704;975.0785507695231;741.0958630470844;932.1191474057019;968.138356862393;968.2641192693533;972.3145182646217;719.061624579923;719.7157122936411;720.0639169080175;720.0890873045602;720.474053940621;14748.926255368762;14792.704145917021;14796.964212505129;14814.333354999051;14829.629259268497;12060.396980151045;12104.81842772359;12254.326012069332;12293.3238671873;12336.923863867802;8722.825543489158;9659.951700241454;9885.308028438012;9933.900660993442;10239.232057595711;3461.2039230976766;3470.1498132957336;3481.2225863622484;3486.9302613947834;3497.3005398920063;70191.24521886943;70320.29679703189;70695;73535.63232183858;74968.62515687496;9234.215091717146;9249.768755781159;9308.767280818034;9437.90562094384;9573.664921727706;21040.842753648696;21231.78768212298;21256.78743212579;21489;21515.67726484104;6400.743970241138;7300.780976570712;7383;7590.658420371096;7715.807104822312;4110.876673699794;4119.9794001030405;4133.586641335843;4177.707560470738;4440;3381.4758712399616;3495.667911548399;3499.527563778908;3507.2459421224557;3512.2097528055983;439.7967161845204;635.2948227467507;643.9291677915426;652.7943697735199;654.6366766444573;502.54519659708023;561.7079118858171;569.3822202909806;585.096026638844;603.9969800150972;7820.608969551499;7983.5209887406945;8150.3479721622125;8151.021877374635;8268.09051004389;569.3026043097173;575.5309422820388;582.6242073862335;590.6338070396296;592.2922108080888;3689.538807649044;3741.607131251234;3811.9047023824073;3895.104126051024;3921.490206273166;81944.59027704824;85841.14158858456;89864;90438;91104.17791644263;73273;75155.24844751482;75405;75413.622931885;76033;67855.32144678589;68505.3149468509;68732.65633671799;68854.65572672104;69127.65436172787;7085.291470852873;7554.811129721801;7737.148913619385;7815.570143642154;8014.479058861389;43545.56454435415;43804.56195438005;43866;43922.560774391844;43950.78024609856;60468;62184.68907655433;62261.377386225555;62474.37525624686;62508.687456562424;10133.18934485254;10165.796684066425;10208;10379.84430233532;10541.472926353805;10952.616658416917;11135;11233.66299011031;11246.381449020382;11648.009919156966;10349.74125646865;10372.273940824372;10414.947925260629;10420.270581059252;10725.463726813472;9453.810923781624;9821.017898210122;10675.092617127631;10699.786004280026;10760.300580462244;10151.543180556744;10473.162147028068;10475.109615682752;10496.842547361948;10528.473576321307;8896.911030889609;9050.366474346996;9067.04795996411;9287.953560232427;9435.962044174998;7861.820726891012;8448.619812108347;8747;8780.165884240987;8912.376133670581 10:08:34 INFO - PROCESS | 1975 | __end_tp_report 10:08:34 INFO - PROCESS | 1975 | __start_cc_report 10:08:34 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,1378 10:08:34 INFO - PROCESS | 1975 | __end_cc_report 10:08:34 INFO - PROCESS | 1975 | __startTimestamp1461690514689__endTimestamp 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | ------- Summary: start ------- 10:08:34 INFO - PROCESS | 1975 | Number of tests: 6 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5674.47 Median:5874.41 stddev:673.39 (11.5%) stddev-sans-first:632.92 10:08:34 INFO - PROCESS | 1975 | Values: 2672.1 3154.4 3415.1 3457.5 3462.2 4677.4 5666.6 5716.3 5725.8 5737.7 5634.2 5691.7 5703.8 5711.3 5722.7 5122.3 5167.0 5209.3 5214.1 5261.4 5212.7 5251.2 5252.0 5266.6 5268.3 4165.5 5199.4 5230.8 5242.6 5251.3 5214.3 5250.5 5251.1 5267.2 5321.6 5011.8 5066.5 5118.9 5183.8 5193.3 4747.3 4920.4 5537.1 5542.9 5553.1 6197.1 6252.5 6253.9 6256.8 6266.3 5013.4 6187.0 6194.3 6324.5 6327.9 5771.6 5809.1 5817.9 5823.4 5874.4 6242.9 6259.7 6270.8 6279.1 6286.6 5941.1 6067.8 6082.4 6108.9 6160.2 6192.9 6208.9 6215.6 6223.8 6227.3 6150.3 6172.7 6191.4 6213.3 6223.2 6094.4 6164.1 6168.5 6211.8 6245.8 4883.2 4908.0 4911.2 4919.7 4922.1 4469.6 4484.9 4499.9 4500.1 4505.8 5655.4 5663.3 5664.2 5671.5 5674.0 5106.3 6110.4 6208.0 6209.8 6232.6 5741.4 5747.8 5748.5 5776.2 5777.8 5404.2 5419.7 5421.2 5428.1 5430.3 6186.3 6258.4 6304.2 6353.7 6369.7 5579.3 5872.4 6188.4 6214.4 6220.2 6191.5 6313.0 6357.5 6373.3 6476.2 5074.8 6109.1 6183.7 6206.3 6210.1 6172.5 6179.8 6186.2 6211.6 6227.3 4669.6 5947.4 6132.2 6145.9 6147.7 6061.5 6074.7 6088.7 6091.7 6128.4 5233.9 5888.9 5925.4 5942.2 5955.2 5790.5 6081.1 6105.9 6108.8 6112.8 5977.8 5979.1 5981.6 5986.0 5997.9 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:49985.52 Median:30071.75 stddev:93656.29 (311.4%) stddev-sans-first:93845.28 10:08:34 INFO - PROCESS | 1975 | Values: 484.0 507.9 510.0 545.4 561.8 24070.0 30146.4 36735.4 37811.6 37871.0 39417.2 40016.6 40106.6 40155.4 40166.6 9267.0 9475.0 9490.5 9506.3 9508.4 8388.4 8576.9 8579.1 8590.4 8609.0 11253.8 11521.9 11529.3 11533.4 11538.6 11276.9 11419.7 11441.9 11455.5 11481.4 8364.4 11027.0 11141.0 11271.5 11317.9 36780.6 37289.6 37336.0 37348.8 37356.6 3168.8 3226.3 3273.2 3421.9 3758.9 26292.2 27694.9 27963.9 28230.9 28347.9 2695.0 2707.9 2712.0 2754.1 2917.7 288870.0 293794.0 294179.5 294898.0 295182.0 57943.7 58113.7 58728.4 58748.8 58823.7 61351.7 61527.1 61549.0 61653.0 61672.7 15857.6 16116.4 16165.9 16482.3 16969.7 11409.0 12591.7 13116.5 13121.0 13123.2 14334.3 15494.7 15937.6 16813.7 18236.0 7489.0 7670.7 7730.1 7733.5 7741.3 985.6 1013.3 1022.5 1073.0 1163.0 27290.9 27678.9 27694.0 27764.6 27910.0 1093.0 1153.8 1165.8 1174.2 1211.3 14569.0 14786.9 14826.9 14959.5 15032.0 461881.7 462703.0 469495.0 470218.0 470623.0 56353.0 56925.7 57011.7 57014.0 57139.4 1293.0 1360.7 1438.5 1481.5 1493.2 27527.9 27654.6 28197.3 28201.9 28437.6 44268.8 44431.7 44844.8 44909.0 44929.0 258951.0 259656.0 259715.0 266512.0 293016.8 21805.8 24238.0 24850.1 25011.6 25026.0 40853.4 41350.8 41725.4 41788.0 42525.4 33549.2 35782.0 35900.5 36689.3 37163.6 34937.0 35175.8 35367.6 36101.5 36177.6 35577.5 35695.1 35926.6 36142.0 36593.0 24972.0 29997.1 31764.0 31861.8 31878.0 22742.5 23197.5 23307.8 23553.6 23796.6 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:31525.81 Median:13354.61 stddev:90961.06 (681.1%) stddev-sans-first:91186.12 10:08:34 INFO - PROCESS | 1975 | Values: 354.4 394.1 395.8 404.2 406.7 15415.8 19825.1 20537.2 20590.0 20640.1 19708.4 20283.8 20314.3 20455.8 20893.8 5192.6 5723.6 5934.2 5950.5 5950.5 6021.4 6042.9 6067.1 6067.6 6080.3 5727.4 5925.8 5945.1 5952.0 5958.8 5754.2 5926.1 5945.9 5948.0 5951.5 4705.2 4958.9 5121.1 5181.7 5221.5 24317.5 24820.9 25203.1 25276.2 25357.9 2106.3 2181.1 2212.6 2258.7 2391.7 11238.8 14832.3 14853.2 15149.5 15244.0 1572.4 1590.7 1617.4 1768.0 1785.7 99739.0 103048.5 103229.5 104153.5 105822.0 9523.3 10377.4 10634.3 10861.5 10999.8 10996.3 12885.0 13630.9 13645.4 13672.7 8333.7 8446.8 8579.6 8681.1 8686.3 7253.0 8550.2 8567.5 8572.4 8675.7 5346.7 6540.5 6555.6 6557.8 6563.0 1577.2 1909.8 1910.7 1932.6 1941.7 903.4 942.9 982.9 1019.3 1037.9 19350.6 19491.8 20146.6 20684.6 20688.8 961.4 970.1 997.7 999.7 1015.4 10677.6 11288.0 11314.1 11326.1 11330.5 539700.0 544932.0 550880.4 558096.0 558442.0 61141.0 79762.4 98791.0 102717.0 103036.0 1008.6 1039.2 1040.6 1042.2 1044.6 17879.6 17932.5 18167.0 18298.6 18608.1 39858.6 40682.0 43779.0 46090.0 48242.0 65163.7 65935.0 66014.3 66202.0 67161.0 7453.4 7570.8 7896.7 7976.7 8365.4 8562.2 11822.4 11840.3 12151.8 12262.1 8502.5 10393.4 10404.9 10709.5 10765.9 10403.4 10465.5 10526.9 10564.2 10706.3 10542.9 10704.0 10843.4 10976.4 11019.1 7966.1 8043.4 8053.0 8328.7 8414.9 10541.8 10566.6 10700.6 10791.9 10940.9 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5671.60 Median:4860.07 stddev:3205.69 (66.0%) stddev-sans-first:3198.36 10:08:34 INFO - PROCESS | 1975 | Values: 1366.9 1613.5 1627.1 1899.6 2035.0 7852.9 8618.4 8848.6 8860.7 8879.8 8486.4 8701.7 8705.7 8707.7 8734.0 2127.4 2202.1 2202.6 2396.1 2438.5 2195.0 2321.0 2402.7 2490.7 2503.3 2412.0 2438.6 2449.1 2451.4 2456.2 2113.3 2418.4 2433.4 2433.6 2436.3 2328.5 2406.4 2407.0 2414.0 2415.6 8576.6 8678.4 8684.9 8688.3 8698.0 5046.0 5301.2 5329.7 5348.1 5361.7 3374.2 3414.4 3476.8 3598.5 3604.3 847.9 934.0 1041.0 1048.3 1049.6 11803.7 11825.2 11851.3 11865.0 11870.3 4342.0 4606.0 4655.3 4722.6 4860.5 10096.3 10133.4 10153.7 10160.5 10167.7 5313.2 5362.3 5372.6 5408.6 5410.3 4210.9 4859.7 4918.5 4955.5 4966.3 3860.3 3867.0 3870.5 3891.4 3975.9 1220.8 1221.5 1233.3 1236.6 1238.0 819.7 882.7 896.0 924.4 938.1 5666.5 5695.5 5849.9 5897.4 5916.2 433.0 445.1 447.2 453.7 457.8 3817.5 3968.3 4044.6 4094.3 4139.3 10504.8 10711.7 10763.0 10891.0 10899.9 9404.6 10016.9 10813.4 10857.9 10874.3 7952.6 8020.5 8090.8 8263.0 8270.0 5343.4 6011.9 6050.6 6096.1 6124.2 9513.7 9617.7 10001.7 10020.7 10153.9 8938.5 9681.1 10265.0 10277.4 10330.0 6108.3 6892.4 7555.6 7557.3 7558.8 8156.4 8164.1 8178.1 8208.8 8261.7 7377.9 7404.9 7482.6 7559.8 7583.1 6330.9 7172.9 7297.2 7361.3 7361.8 7053.2 7132.1 7138.7 7159.7 7164.7 4680.3 4905.6 4939.2 4967.2 4978.7 4739.4 4888.4 4985.8 4986.1 5207.6 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:4420.06 Median:4909.71 stddev:1369.99 (27.9%) stddev-sans-first:1338.74 10:08:34 INFO - PROCESS | 1975 | Values: 314.9 315.5 321.1 324.3 326.7 4193.7 4405.3 5120.8 5139.6 5187.4 3776.8 4064.9 5105.7 5128.5 5151.9 3809.8 3871.5 3883.3 3998.4 4003.8 3604.5 3640.5 3896.5 3958.2 3960.3 3580.8 3930.5 3945.7 3955.5 3959.0 3688.8 3725.9 3740.3 3836.6 3840.7 3088.4 3133.9 3430.8 3455.8 3490.3 4048.8 4182.3 4896.1 4922.2 4977.9 3573.9 3772.0 4444.9 4506.6 4524.5 3987.9 5010.3 5255.3 5315.3 5321.7 3501.8 3551.6 3616.8 3812.9 3843.3 4165.4 4790.7 5194.8 5308.5 5552.9 3478.6 3550.9 3871.2 3873.8 3914.7 3960.0 3976.2 3979.8 3990.7 3998.5 4469.4 4484.7 4540.8 4541.1 4609.4 5144.0 5354.4 5382.5 5396.3 5414.6 1339.9 1428.6 1431.0 1441.0 1447.2 747.3 795.5 899.3 979.8 987.7 4061.5 4619.7 4961.0 5004.8 5177.4 4897.3 5221.8 5413.3 5593.7 5611.0 5039.5 5051.4 5071.2 5077.1 5100.1 2396.8 3160.1 3169.6 3170.4 3183.9 5407.7 6189.0 6216.6 6238.6 6288.2 5489.9 5592.2 5930.3 5986.9 6141.7 5015.8 5453.5 5510.0 6255.9 6334.2 4752.4 6031.2 6035.3 6041.2 6066.2 5457.8 5965.0 6000.3 6031.8 6077.2 5455.8 5479.5 6303.4 6314.8 6333.5 3612.2 3698.8 4136.5 4167.8 4167.9 4980.8 5493.9 5543.9 5561.8 5606.8 4806.4 4987.9 5150.2 5443.7 5450.8 4688.9 5052.4 5390.5 5410.2 5420.2 4194.0 5224.4 5263.9 5299.5 5314.5 4540.0 4562.9 4653.8 4892.9 5333.4 4931.6 5305.8 5332.5 5361.7 5436.3 10:08:34 INFO - PROCESS | 1975 | 10:08:34 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:17238.62 Median:3518.02 stddev:24037.54 (683.3%) stddev-sans-first:24072.81 10:08:34 INFO - PROCESS | 1975 | Values: 679.4 692.0 730.6 734.4 768.3 14559.4 15213.8 15219.2 15220.8 15228.6 13600.0 13707.7 13749.5 13764.4 13790.4 712.6 734.8 876.5 886.8 905.9 905.8 909.6 914.4 914.7 915.4 968.4 970.0 973.7 974.4 975.1 741.1 932.1 968.1 968.3 972.3 719.1 719.7 720.1 720.1 720.5 14748.9 14792.7 14797.0 14814.3 14829.6 12060.4 12104.8 12254.3 12293.3 12336.9 8722.8 9660.0 9885.3 9933.9 10239.2 3461.2 3470.1 3481.2 3486.9 3497.3 70191.2 70320.3 70695.0 73535.6 74968.6 9234.2 9249.8 9308.8 9437.9 9573.7 21040.8 21231.8 21256.8 21489.0 21515.7 6400.7 7300.8 7383.0 7590.7 7715.8 4110.9 4120.0 4133.6 4177.7 4440.0 3381.5 3495.7 3499.5 3507.2 3512.2 439.8 635.3 643.9 652.8 654.6 502.5 561.7 569.4 585.1 604.0 7820.6 7983.5 8150.3 8151.0 8268.1 569.3 575.5 582.6 590.6 592.3 3689.5 3741.6 3811.9 3895.1 3921.5 81944.6 85841.1 89864.0 90438.0 91104.2 73273.0 75155.2 75405.0 75413.6 76033.0 67855.3 68505.3 68732.7 68854.7 69127.7 7085.3 7554.8 7737.1 7815.6 8014.5 43545.6 43804.6 43866.0 43922.6 43950.8 60468.0 62184.7 62261.4 62474.4 62508.7 10133.2 10165.8 10208.0 10379.8 10541.5 10952.6 11135.0 11233.7 11246.4 11648.0 10349.7 10372.3 10414.9 10420.3 10725.5 9453.8 9821.0 10675.1 10699.8 10760.3 10151.5 10473.2 10475.1 10496.8 10528.5 8896.9 9050.4 9067.0 9288.0 9436.0 7861.8 8448.6 8747.0 8780.2 8912.4 10:08:34 INFO - PROCESS | 1975 | -------- Summary: end -------- 10:08:34 INFO - PROCESS | 1975 | 10:08:35 INFO - TEST-INFO | 1975: exit 0 10:08:35 INFO - TEST-OK | dromaeo_css | took 1115427ms 10:08:35 INFO - TEST-START | kraken 10:08:35 INFO - operating with platform_type : mac_ 10:08:35 INFO - Initialising browser for kraken test... 10:08:35 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpSKJrWN/profile http://localhost:49515/getInfo.html) 10:08:37 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 10:08:37 INFO - PROCESS | 1979 | colorDepth:24 10:08:37 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 10:08:37 INFO - PROCESS | 1979 | __metrics 10:08:37 INFO - PROCESS | 1979 | 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" 10:08:37 ERROR - PROCESS | 1979 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:08:38 INFO - TEST-INFO | 1979: exit 0 10:08:38 INFO - Browser initialized. 10:08:38 INFO - Running cycle 1/1 for kraken test... 10:08:38 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpSKJrWN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:50 INFO - PROCESS | 1981 | RSS: Main: 239259648 10:08:50 INFO - PROCESS | 1981 | 10:08:52 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:53 INFO - PROCESS | 1981 | RSS: Main: 286085120 10:08:53 INFO - PROCESS | 1981 | 10:08:56 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-dft) 10:08:56 INFO - PROCESS | 1981 | RSS: Main: 299216896 10:08:56 INFO - PROCESS | 1981 | 10:09:00 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-fft) 10:09:01 INFO - PROCESS | 1981 | RSS: Main: 386015232 10:09:01 INFO - PROCESS | 1981 | 10:09:03 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-oscillator) 10:09:03 INFO - PROCESS | 1981 | RSS: Main: 286576640 10:09:03 INFO - PROCESS | 1981 | 10:09:06 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:06 INFO - PROCESS | 1981 | RSS: Main: 290795520 10:09:06 INFO - PROCESS | 1981 | 10:09:09 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:10 INFO - PROCESS | 1981 | RSS: Main: 329457664 10:09:10 INFO - PROCESS | 1981 | 10:09:13 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:13 INFO - PROCESS | 1981 | RSS: Main: 331313152 10:09:13 INFO - PROCESS | 1981 | 10:09:16 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49515/tests/kraken/driver.html?testName=json-parse-financial) 10:09:17 INFO - PROCESS | 1981 | RSS: Main: 328351744 10:09:17 INFO - PROCESS | 1981 | 10:09:18 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:19 INFO - PROCESS | 1981 | RSS: Main: 321269760 10:09:19 INFO - PROCESS | 1981 | 10:09:21 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:21 INFO - PROCESS | 1981 | RSS: Main: 328085504 10:09:21 INFO - PROCESS | 1981 | 10:09:23 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:24 INFO - PROCESS | 1981 | RSS: Main: 330563584 10:09:24 INFO - PROCESS | 1981 | 10:09:27 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:28 INFO - PROCESS | 1981 | RSS: Main: 334880768 10:09:28 INFO - PROCESS | 1981 | 10:09:31 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:32 INFO - PROCESS | 1981 | RSS: Main: 332558336 10:09:32 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49515/tests/kraken/driver.html?testName=ai-astar) 10:09:33 INFO - PROCESS | 1981 | RSS: Main: 397815808 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | __start_tp_report 10:09:33 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 10:09:33 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 10:09:33 INFO - PROCESS | 1981 | |i|pagename|runs| 10:09:33 INFO - PROCESS | 1981 | |0;ai-astar;114;112;109;113;114;113;113;113;106;112 10:09:33 INFO - PROCESS | 1981 | |1;audio-beat-detection;156;128;139;172;121;144;142;120;174;117 10:09:33 INFO - PROCESS | 1981 | |2;audio-dft;182;188;184;183;186;181;184;181;244;185 10:09:33 INFO - PROCESS | 1981 | |3;audio-fft;79;73;90;92;66;87;68;83;86;56 10:09:33 INFO - PROCESS | 1981 | |4;audio-oscillator;89;101;136;78;81;80;154;118;114;127 10:09:33 INFO - PROCESS | 1981 | |5;imaging-gaussian-blur;89;88;90;86;132;87;91;88;90;85 10:09:33 INFO - PROCESS | 1981 | |6;imaging-darkroom;95;95;96;108;149;131;95;96;95;95 10:09:33 INFO - PROCESS | 1981 | |7;imaging-desaturate;84;85;84;84;83;85;87;83;84;85 10:09:33 INFO - PROCESS | 1981 | |8;json-parse-financial;45;80;79;85;85;82;66;78;59;57 10:09:33 INFO - PROCESS | 1981 | |9;json-stringify-tinderbox;65;62;73;79;71;67;70;67;68;69 10:09:33 INFO - PROCESS | 1981 | |10;stanford-crypto-aes;83;83;83;82;81;82;81;81;83;83 10:09:33 INFO - PROCESS | 1981 | |11;stanford-crypto-ccm;157;164;136;136;140;137;137;138;176;158 10:09:33 INFO - PROCESS | 1981 | |12;stanford-crypto-pbkdf2;196;198;197;197;193;193;195;203;196;195 10:09:33 INFO - PROCESS | 1981 | |13;stanford-crypto-sha256-iterative;70;68;70;69;69;67;69;70;69;68 10:09:33 INFO - PROCESS | 1981 | __end_tp_report 10:09:33 INFO - PROCESS | 1981 | __start_cc_report 10:09:33 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,2016 10:09:33 INFO - PROCESS | 1981 | __end_cc_report 10:09:33 INFO - PROCESS | 1981 | __startTimestamp1461690573969__endTimestamp 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | ------- Summary: start ------- 10:09:33 INFO - PROCESS | 1981 | Number of tests: 14 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.51 (2.2%) stddev-sans-first:2.55 10:09:33 INFO - PROCESS | 1981 | Values: 114.0 112.0 109.0 113.0 114.0 113.0 113.0 113.0 106.0 112.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:143.00 stddev:20.75 (14.5%) stddev-sans-first:21.31 10:09:33 INFO - PROCESS | 1981 | Values: 156.0 128.0 139.0 172.0 121.0 144.0 142.0 120.0 174.0 117.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#2] audio-dft Cycles:10 Average:189.80 Median:184.50 stddev:19.17 (10.4%) stddev-sans-first:20.12 10:09:33 INFO - PROCESS | 1981 | Values: 182.0 188.0 184.0 183.0 186.0 181.0 184.0 181.0 244.0 185.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#3] audio-fft Cycles:10 Average:78.00 Median:84.50 stddev:11.85 (14.0%) stddev-sans-first:12.56 10:09:33 INFO - PROCESS | 1981 | Values: 79.0 73.0 90.0 92.0 66.0 87.0 68.0 83.0 86.0 56.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:116.00 stddev:26.29 (22.7%) stddev-sans-first:26.99 10:09:33 INFO - PROCESS | 1981 | Values: 89.0 101.0 136.0 78.0 81.0 80.0 154.0 118.0 114.0 127.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:88.50 stddev:13.97 (15.8%) stddev-sans-first:14.76 10:09:33 INFO - PROCESS | 1981 | Values: 89.0 88.0 90.0 86.0 132.0 87.0 91.0 88.0 90.0 85.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:95.00 stddev:19.09 (20.1%) stddev-sans-first:19.87 10:09:33 INFO - PROCESS | 1981 | Values: 95.0 95.0 96.0 108.0 149.0 131.0 95.0 96.0 95.0 95.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 10:09:33 INFO - PROCESS | 1981 | Values: 84.0 85.0 84.0 84.0 83.0 85.0 87.0 83.0 84.0 85.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:79.50 stddev:13.92 (17.5%) stddev-sans-first:10.94 10:09:33 INFO - PROCESS | 1981 | Values: 45.0 80.0 79.0 85.0 85.0 82.0 66.0 78.0 59.0 57.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:4.65 (6.7%) stddev-sans-first:4.69 10:09:33 INFO - PROCESS | 1981 | Values: 65.0 62.0 73.0 79.0 71.0 67.0 70.0 67.0 68.0 69.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 10:09:33 INFO - PROCESS | 1981 | Values: 83.0 83.0 83.0 82.0 81.0 82.0 81.0 81.0 83.0 83.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:148.50 stddev:14.59 (9.8%) stddev-sans-first:15.10 10:09:33 INFO - PROCESS | 1981 | Values: 157.0 164.0 136.0 136.0 140.0 137.0 137.0 138.0 176.0 158.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:196.50 stddev:2.87 (1.5%) stddev-sans-first:3.04 10:09:33 INFO - PROCESS | 1981 | Values: 196.0 198.0 197.0 197.0 193.0 193.0 195.0 203.0 196.0 195.0 10:09:33 INFO - PROCESS | 1981 | 10:09:33 INFO - PROCESS | 1981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 10:09:33 INFO - PROCESS | 1981 | Values: 70.0 68.0 70.0 69.0 69.0 67.0 69.0 70.0 69.0 68.0 10:09:33 INFO - PROCESS | 1981 | -------- Summary: end -------- 10:09:33 INFO - PROCESS | 1981 | 10:09:34 INFO - TEST-INFO | 1981: exit 0 10:09:34 INFO - TEST-OK | kraken | took 59456ms 10:09:34 INFO - SUITE-END | took 1174s 10:09:35 INFO - Completed test suite (00:19:35) 10:09:35 INFO - javascript benchmark 10:09:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.144913627639, 3154.447971604969, 3415.1120708615767, 3457.464093065574, 3462.1690794209367, 4677.368555245041, 5666.631668941516, 5716.3426205986325, 5725.828225153246, 5737.6557406555585, 5634.239377684022, 5691.686957217351, 5703.800366987156, 5711.343195532515, 5722.7424765885535, 5122.308488354071, 5166.974165129169, 5209.32278803755, 5214.0875346814155, 5261.421243663194, 5212.687238765686, 5251.212318152269, 5251.975864706384, 5266.552343050846, 5268.262443257947, 4165.520965089023, 5199.376074871002, 5230.764615592308, 5242.606804489678, 5251.291075704769, 5214.348206474172, 5250.501202385767, 5251.081060814342, 5267.209918512215, 5321.600879934021, 5011.84964451067, 5066.518680725325, 5118.92784036558, 5183.818566350197, 5193.324867767166, 4747.264174053027, 4920.384951881015, 5537.058700021006, 5542.91685624716, 5553.0837411827, 6197.0704394340755, 6252.499800015988, 6253.906191407133, 6256.843578910518, 6266.3420340864, 5013.448520662724, 6186.969065154691, 6194.256689197326, 6324.494040476751, 6327.8734425311695, 5771.6248443851855, 5809.128630705343, 5817.94182058174, 5823.417658234185, 5874.412558744134, 6242.937570624235, 6259.655718935411, 6270.811875643738, 6279.058141278845, 6286.591371560834, 5941.079132734433, 6067.848303792441, 6082.36135205797, 6108.938910610837, 6160.229971253593, 6192.938070619326, 6208.937910620926, 6215.627062376272, 6223.782167624111, 6227.346128656426, 6150.261968563801, 6172.69136543171, 6191.380861913863, 6213.254409470893, 6223.190985171989, 6094.421030002142, 6164.137020817089, 6168.537359698041, 6211.751529938751, 6245.843853903689, 4883.218685010382, 4907.975460122748, 4911.18965370717, 4919.729414882144, 4922.064807686528, 4469.642428605704, 4484.887877803016, 4499.910001800011, 4500.054988452462, 4505.819767209275, 5655.3779084300695, 5663.320401551758, 5664.235328230719, 5671.546276297886, 5673.978683836866, 5106.310648062538, 6110.419510146529, 6208.00671892495, 6209.751609935552, 6232.56372053961, 5741.368449470555, 5747.827565173052, 5748.45389687979, 5776.191333213354, 5777.7977770777825, 5404.189371594292, 5419.701916394557, 5421.2139239810795, 5428.104362780176, 5430.348358196962, 6186.319504854462, 6258.405451482102, 6304.243490781136, 6353.745850166034, 6369.713362898773, 5579.302587176603, 5872.354041055395, 6188.350223226496, 6214.40963108504, 6220.222472190976, 6191.504679625709, 6313.033647695745, 6357.491400688026, 6373.267074286517, 6476.190476190476, 5074.771635276347, 6109.131392048963, 6183.659898705614, 6206.255249370104, 6210.130581718653, 6172.506199503939, 6179.84550386226, 6186.226721659793, 6211.596246243979, 6227.346128656426, 4669.649776266726, 5947.434993675594, 6132.233470816148, 6145.907811382922, 6147.692615369124, 6061.515078793598, 6074.696265186634, 6088.726007329769, 6091.695415229309, 6128.448439640454, 5233.874716935877, 5888.882222355443, 5925.377835327228, 5942.168096466585, 5955.225820643289, 5790.536757059341, 6081.057436097412, 6105.914670190187, 6108.786192483241, 6112.816615501542, 5977.760889564369, 5979.073243647242, 5981.611195272293, 5985.952458319864, 5997.880042399215], "value": 5632.189983008016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.96128309735224, 507.946665600112, 509.97195154266524, 545.405507996284, 561.8005608009157, 24070.0, 30146.397072058575, 36735.44896826547, 37811.621883781154, 37871.0, 39417.21165576687, 40016.59983400165, 40106.59893401065, 40155.39766903499, 40166.59416920409, 9266.953665231682, 9475.0, 9490.52547372632, 9506.334556581041, 9508.429494230368, 8388.37087218461, 8576.871346929769, 8579.056303806576, 8590.441621294596, 8608.956955215215, 11253.774924501546, 11521.884781152206, 11529.250598711098, 11533.365664888428, 11538.596149134783, 11276.887231127706, 11419.657410277705, 11441.885581144164, 11455.484503197376, 11481.425928703573, 8364.37267204962, 11027.0075693188, 11141.0, 11271.492782824711, 11317.943410282896, 36780.632193677986, 37289.62710372916, 37336.0, 37348.81325593355, 37356.62643373559, 3168.7940283881476, 3226.3386005868742, 3273.165342837585, 3421.9315613687586, 3758.924821503582, 26292.21123366302, 27694.861525692242, 27963.860180698965, 28230.87076516937, 28347.858260708563, 2694.9865250673815, 2707.878145483458, 2711.959320610192, 2754.0911499205213, 2917.679055303915, 288870.0, 293794.0, 294179.52910235524, 294898.0, 295182.0, 57943.710281449166, 58113.709431452575, 58728.41271587315, 58748.82502349929, 58823.70588147118, 61351.71751813448, 61527.077093843625, 61549.0, 61653.0, 61672.691636542426, 15857.603559911095, 16116.355345786038, 16165.919170404073, 16482.34070637185, 16969.745453818203, 11409.0, 12591.6778738233, 13116.540921067908, 13121.015923805753, 13123.212607243597, 14334.283285835667, 15494.690106197813, 15937.601559961095, 16813.747793783103, 18236.0, 7489.0, 7670.7315243966195, 7730.072391313079, 7733.49732267412, 7741.303282704471, 985.610683779903, 1013.2603199664286, 1022.4734261855151, 1072.953869976782, 1162.9649611845296, 27290.908363665232, 27678.861605692244, 27694.0, 27764.583531247048, 27910.0, 1092.9672109836717, 1153.763478486908, 1165.7817580628264, 1174.236746115032, 1211.2611307102661, 14569.0, 14786.852131478547, 14826.851731482762, 14959.476418325525, 15032.0, 461881.6905915449, 462703.0, 469495.0, 470218.0, 470623.0, 56353.0, 56925.71537142288, 57011.71494142503, 57014.0, 57139.428605714245, 1292.9612111636666, 1360.693843885118, 1438.4749566408395, 1481.5111013365563, 1493.171289934097, 27527.86236068807, 27654.585181221897, 28197.295067622654, 28201.858990704914, 28437.573436398055, 44268.778656106515, 44431.66704998855, 44844.775776120914, 44908.99999999869, 44929.0, 258951.0, 259656.0, 259715.0, 266512.0, 293016.8142433638, 21805.78194218101, 24238.0, 24850.130245441323, 25011.624825627267, 25026.0, 40853.38719919144, 41350.79324603358, 41725.37411938884, 41788.0, 42525.36211956885, 33549.2124410331, 35782.0, 35900.461493077106, 36689.26621467609, 37163.628363716016, 34937.0, 35175.82412087923, 35367.64632353746, 36101.45847812337, 36177.63822361848, 35577.46633800547, 35695.10762230965, 35926.64073359233, 36142.0, 36593.0, 24972.0, 29997.100086997423, 31764.0, 31861.840690796398, 31878.0, 22742.545149097255, 23197.536049279257, 23307.76692233056, 23553.646695299925, 23796.643050354603], "value": 18499.971404861444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.4293687163666, 394.1407731146101, 395.7684754418665, 404.1895998522961, 406.65434380776344, 15415.768763468543, 19825.107870145843, 20537.178512859486, 20590.0, 20640.071196796143, 19708.408747737554, 20283.797162028375, 20314.288999885008, 20455.795442045575, 20893.791062089374, 5192.55863251624, 5723.570732195081, 5934.228550288456, 5950.494207992326, 5950.523958083343, 6021.367756385582, 6042.879142417149, 6067.120267561201, 6067.605605635619, 6080.30076541199, 5727.3699893011735, 5925.814837032589, 5945.108233764927, 5952.0, 5958.79144229952, 5754.165645981351, 5926.111083337512, 5945.940540594604, 5948.048312270016, 5951.49412299955, 4705.223638099709, 4958.900821983576, 5121.078205922932, 5181.689098654093, 5221.477852214748, 24317.513649726905, 24820.875895620586, 25203.11789087373, 25276.241712748462, 25357.873210634014, 2106.252280440452, 2181.1057466438842, 2212.6459766437456, 2258.683784270187, 2391.712994440661, 11238.775224495464, 14832.332545035499, 14853.183074930874, 15149.469768558047, 15244.0, 1572.4417831669707, 1590.7136715391225, 1617.4015614222694, 1767.9734803977951, 1785.6875046866746, 99739.0, 103048.48475757649, 103229.483852581, 104153.47923260335, 105822.0, 9523.28575356851, 10377.429241391645, 10634.255602107933, 10861.456927153611, 10999.765090440078, 10996.340219586851, 12885.0, 13630.93184534071, 13645.43077546075, 13672.726545469035, 8333.6666533338, 8446.831063378699, 8579.613917373734, 8681.088485709037, 8686.261667758185, 7252.963735181396, 8550.187732165434, 8567.485950842969, 8572.35707321941, 8675.739727808175, 5346.743515273907, 6540.542162048706, 6555.573887697285, 6557.803265901935, 6563.0, 1577.242923396776, 1909.8185672361103, 1910.6751852185162, 1932.603816217672, 1941.6990366493217, 903.4488961733338, 942.9292803039799, 982.9017098290257, 1019.3425240719695, 1037.896210378971, 19350.61298774045, 19491.805081948998, 20146.597068058556, 20684.58630827375, 20688.793112068986, 961.3606951377255, 970.1075010989906, 997.6607953295769, 999.6801023672355, 1015.3653966271081, 10677.57289708403, 11288.04051655602, 11314.094872410187, 11326.093912486982, 11330.490127944262, 539700.0, 544932.0, 550880.4207621333, 558096.0, 558442.0, 61141.0, 79762.40475190464, 98791.0, 102717.0, 103036.0, 1008.6469735592484, 1039.1686650679426, 1040.5577629507277, 1042.155853758458, 1044.6343779677204, 17879.553011174823, 17932.462026139237, 18167.0, 18298.634027319644, 18608.06959651985, 39858.60141398549, 40682.0, 43779.0, 46090.0, 48242.0, 65163.69672606426, 65935.0, 66014.33985660083, 66202.0, 67161.0, 7453.366463850633, 7570.81072973158, 7896.7236146734585, 7976.7208147714555, 8365.372597055368, 8562.159135785836, 11822.40887955616, 11840.348780817138, 12151.817722734342, 12262.08034397406, 8502.489850608983, 10393.37639741618, 10404.895951040393, 10709.518071686949, 10765.89234107649, 10403.375797452178, 10465.47672616351, 10526.947365263431, 10564.154867610727, 10706.250562460553, 10542.894571054192, 10704.0, 10843.403612801372, 10976.396298203676, 11019.118470522499, 7966.123726389977, 8043.356531477585, 8053.0, 8328.708495202638, 8414.87377689323, 10541.789164216827, 10566.577336906745, 10700.571977120828, 10791.946040269748, 10940.945295273472], "value": 9310.546103518707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.863313668634, 1613.4514265149846, 1627.0969611865414, 1899.6105798311348, 2034.9796502034985, 7852.882206766896, 8618.439801412904, 8848.646054157842, 8860.734177974671, 8879.822403551932, 8486.405951583392, 8701.695440659578, 8705.65177392905, 8707.73876783696, 8733.956330218356, 2127.4255950893325, 2202.119152339061, 2202.6255536558742, 2396.149366974729, 2438.548868459332, 2194.9780502194935, 2320.9883950580224, 2402.699662542182, 2490.6762120924254, 2503.3115893129443, 2411.9758802411925, 2438.5610590093775, 2449.130558651671, 2451.4361696809747, 2456.1771806444863, 2113.260358874397, 2418.3833122553724, 2433.415980164765, 2433.5741245282184, 2436.281297017384, 2328.52265285616, 2406.422458609921, 2407.0, 2413.9861258271567, 2415.553122672311, 8576.571171441465, 8678.392512524126, 8684.869726954037, 8688.348373871922, 8697.95651021741, 5045.974770126162, 5301.1783173608155, 5329.706866122362, 5348.144296912515, 5361.705106219157, 3374.190194353362, 3414.402479566066, 3476.8435420406145, 3598.460230965376, 3604.2611264690677, 847.9152084791533, 933.9533023348873, 1041.0058394233488, 1048.2505008918583, 1049.6378749331468, 11803.704907377385, 11825.172237943347, 11851.348175850238, 11865.0, 11870.347130907796, 4342.023044814891, 4606.0, 4655.255159174516, 4722.598579120745, 4860.465348811628, 10096.343737657176, 10133.391996480235, 10153.695389138338, 10160.4919754012, 10167.694969150938, 5313.229581710631, 5362.302900622894, 5372.62391632582, 5408.594355423359, 5410.296661433988, 4210.915781684349, 4859.684120532224, 4918.508149185124, 4955.4548999610015, 4966.304717339575, 3860.2665493556133, 3866.994581408854, 3870.4581358609817, 3891.416287556889, 3975.940360894589, 1220.7741567809983, 1221.4564518789055, 1233.272369302116, 1236.5610208376077, 1238.0095923261356, 819.7049062337554, 882.6557642519423, 895.9731208063769, 924.4083786376724, 938.0853667673963, 5666.518345940559, 5695.45893140151, 5849.912251316234, 5897.439743224387, 5916.23088998436, 433.0343334364385, 445.12755000199326, 447.1838894018429, 453.68922288232665, 457.77340216593, 3817.522809648794, 3968.2857085724845, 4044.6359827615656, 4094.3449048152747, 4139.275626765304, 10504.842427363596, 10711.732206694895, 10763.0, 10891.0, 10899.945500272448, 9404.576794044284, 10016.949915250523, 10813.405262710627, 10857.891421085846, 10874.347539147677, 7952.602369881482, 8020.51876887377, 8090.757277281691, 8262.958685206655, 8270.007599088027, 5343.438938911514, 6011.90982135277, 6050.606710563799, 6096.116063170904, 6124.234470691164, 9513.66702165421, 9617.71146865595, 10001.749956251151, 10020.69937901864, 10153.898461015295, 8938.46369217849, 9681.080297371738, 10264.973502649975, 10277.434741089013, 10329.96700329961, 6108.328083910855, 6892.414144797548, 7555.622218888923, 7557.2820582044615, 7558.811029724301, 8156.429049966446, 8164.061132969547, 8178.141295163922, 8208.753737387888, 8261.710840120568, 7377.926220737724, 7404.888926666212, 7482.551046937201, 7559.773206803805, 7583.05211848519, 6330.905036424365, 7172.856542869218, 7297.1973082961895, 7361.319864378325, 7361.779146625609, 7053.188883278489, 7132.144142702701, 7138.678759455941, 7159.749408770668, 7164.713411463692, 4680.274557443602, 4905.552861905675, 4939.185034469416, 4967.230079337708, 4978.6763860348965, 4739.431268247832, 4888.364512613338, 4985.775640096277, 4986.127427700066, 5207.5833933286], "value": 4476.463712473417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9480335744602, 315.45741324921136, 321.10251846090176, 324.32216667165625, 326.6765901757258, 4193.685473589478, 4405.33919912013, 5120.820771273002, 5139.614528910332, 5187.4034486034025, 3776.811159442024, 4064.8780536583877, 5105.744712764365, 5128.4871512848695, 5151.871203219912, 3809.8285577149095, 3871.4835357018023, 3883.3204189266908, 3998.4402183694306, 4003.799810009488, 3604.4593311003428, 3640.507391969293, 3896.4739760132443, 3958.247932892741, 3960.2673505401594, 3580.838862251192, 3930.5479869815053, 3945.7040721945827, 3955.525336959569, 3958.9802050989706, 3688.7642639715727, 3725.9008592465016, 3740.3454395480817, 3836.635519625645, 3840.6927445804267, 3088.3977624363256, 3133.8746450141966, 3430.8335166043667, 3455.7926524408363, 3490.336836001177, 4048.7853643907006, 4182.2890108681295, 4896.143174944406, 4922.16323225049, 4977.925331120036, 3573.874914377984, 3771.9627102546747, 4444.888877778049, 4506.639468842484, 4524.45706515217, 3987.920241595181, 5010.298558201855, 5255.316808814868, 5315.255864179018, 5321.680699158062, 3501.77238479498, 3551.5915669698056, 3616.8372423241017, 3812.866549670748, 3843.327417701919, 4165.354370072643, 4790.736509491977, 5194.831162988336, 5308.478472725463, 5552.889422115552, 3478.5825700915548, 3550.899221241423, 3871.19989205021, 3873.767573945572, 3914.6868250539887, 3959.9604003959594, 3976.204759048202, 3979.7811120388656, 3990.700697447703, 3998.5001874765653, 4469.374287599739, 4484.663650226246, 4540.79566419512, 4541.137183935108, 4609.400777898852, 5143.965060614256, 5354.357477102694, 5382.542483888913, 5396.271503347077, 5414.566834653218, 1339.914669117998, 1428.557147284345, 1431.0, 1441.040185347926, 1447.1751101872042, 747.3386053342831, 795.5028107432854, 899.3344924755634, 979.7893452907659, 987.6691308411619, 4061.481881233654, 4619.676622636451, 4960.975195124073, 5004.774785134678, 5177.430482646906, 4897.253600995242, 5221.825089354865, 5413.323334583177, 5593.74828132735, 5610.998116007998, 5039.4708555601865, 5051.368578927634, 5071.163258062452, 5077.086124497552, 5100.1074811907765, 2396.7962723168375, 3160.146760374686, 3169.6037995250595, 3170.365926814646, 3183.8567264473154, 5407.729613519308, 6189.0, 6216.595921265103, 6238.563300569007, 6288.213973253343, 5489.945100549024, 5592.161175823659, 5930.347661757203, 5986.898974202598, 6141.692915354214, 5015.799368025238, 5453.536449401845, 5510.008198524304, 6255.906161407583, 6334.208223972004, 4752.429708434872, 6031.155638210566, 6035.336113027475, 6041.154238406539, 6066.241719785027, 5457.799284157479, 5964.970175149097, 6000.309809467059, 6031.788887388921, 6077.179580756541, 5455.8363249102595, 5479.53423958968, 6303.401176888188, 6314.778982735582, 6333.493320534439, 3612.187257866959, 3698.815059246973, 4136.544980052252, 4167.7702429200235, 4167.874963751093, 4980.754811297175, 5493.917591236214, 5543.8891222174525, 5561.775289884079, 5606.831795046155, 4806.351142595705, 4987.850364489072, 5150.1502252127975, 5443.673379597237, 5450.836474905759, 4688.859334219979, 5052.418971818288, 5390.460953904578, 5410.161424979135, 5420.214068960057, 4194.0, 5224.373075230997, 5263.868403289948, 5299.470052994824, 5314.535789936472, 4540.003597625551, 4562.88592785183, 4653.767311634472, 4892.902141957212, 5333.439908877854, 4931.605471562195, 5305.814296499604, 5332.493413125747, 5361.713188834729, 5436.293281873332], "value": 4003.059437428197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.3817625960377, 692.0000599134253, 730.6346826586704, 734.4198083514024, 768.2547928509346, 14559.417623295069, 15213.84786152138, 15219.16294603795, 15220.847791522081, 15228.61928451788, 13600.04799664024, 13707.72584548311, 13749.450021999108, 13764.38060287287, 13790.448382064706, 712.5973824788978, 734.7685479074102, 876.51791514667, 886.769439945614, 905.9048799876017, 905.8233644439337, 909.6315992023208, 914.3553794574842, 914.6981496106303, 915.4004127296598, 968.3995922528043, 969.9660511882086, 973.7176218896511, 974.44456659704, 975.0785507695231, 741.0958630470844, 932.1191474057019, 968.138356862393, 968.2641192693533, 972.3145182646217, 719.061624579923, 719.7157122936411, 720.0639169080175, 720.0890873045602, 720.474053940621, 14748.926255368762, 14792.704145917021, 14796.964212505129, 14814.333354999051, 14829.629259268497, 12060.396980151045, 12104.81842772359, 12254.326012069332, 12293.3238671873, 12336.923863867802, 8722.825543489158, 9659.951700241454, 9885.308028438012, 9933.900660993442, 10239.232057595711, 3461.2039230976766, 3470.1498132957336, 3481.2225863622484, 3486.9302613947834, 3497.3005398920063, 70191.24521886943, 70320.29679703189, 70695.0, 73535.63232183858, 74968.62515687496, 9234.215091717146, 9249.768755781159, 9308.767280818034, 9437.90562094384, 9573.664921727706, 21040.842753648696, 21231.78768212298, 21256.78743212579, 21489.0, 21515.67726484104, 6400.743970241138, 7300.780976570712, 7383.0, 7590.658420371096, 7715.807104822312, 4110.876673699794, 4119.9794001030405, 4133.586641335843, 4177.707560470738, 4440.0, 3381.4758712399616, 3495.667911548399, 3499.527563778908, 3507.2459421224557, 3512.2097528055983, 439.7967161845204, 635.2948227467507, 643.9291677915426, 652.7943697735199, 654.6366766444573, 502.54519659708023, 561.7079118858171, 569.3822202909806, 585.096026638844, 603.9969800150972, 7820.608969551499, 7983.5209887406945, 8150.3479721622125, 8151.021877374635, 8268.09051004389, 569.3026043097173, 575.5309422820388, 582.6242073862335, 590.6338070396296, 592.2922108080888, 3689.538807649044, 3741.607131251234, 3811.9047023824073, 3895.104126051024, 3921.490206273166, 81944.59027704824, 85841.14158858456, 89864.0, 90438.0, 91104.17791644263, 73273.0, 75155.24844751482, 75405.0, 75413.622931885, 76033.0, 67855.32144678589, 68505.3149468509, 68732.65633671799, 68854.65572672104, 69127.65436172787, 7085.291470852873, 7554.811129721801, 7737.148913619385, 7815.570143642154, 8014.479058861389, 43545.56454435415, 43804.56195438005, 43866.0, 43922.560774391844, 43950.78024609856, 60468.0, 62184.68907655433, 62261.377386225555, 62474.37525624686, 62508.687456562424, 10133.18934485254, 10165.796684066425, 10208.0, 10379.84430233532, 10541.472926353805, 10952.616658416917, 11135.0, 11233.66299011031, 11246.381449020382, 11648.009919156966, 10349.74125646865, 10372.273940824372, 10414.947925260629, 10420.270581059252, 10725.463726813472, 9453.810923781624, 9821.017898210122, 10675.092617127631, 10699.786004280026, 10760.300580462244, 10151.543180556744, 10473.162147028068, 10475.109615682752, 10496.842547361948, 10528.473576321307, 8896.911030889609, 9050.366474346996, 9067.04795996411, 9287.953560232427, 9435.962044174998, 7861.820726891012, 8448.619812108347, 8747.0, 8780.165884240987, 8912.376133670581], "value": 6638.336616554254, "unit": "score"}], "name": "dromaeo_css", "value": 6977.648661944511, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 109.0, 113.0, 114.0, 113.0, 113.0, 113.0, 106.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 139.0, 172.0, 121.0, 144.0, 142.0, 120.0, 174.0, 117.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 184.0, 183.0, 186.0, 181.0, 184.0, 181.0, 244.0, 185.0], "value": 189.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 90.0, 92.0, 66.0, 87.0, 68.0, 83.0, 86.0, 56.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 136.0, 78.0, 81.0, 80.0, 154.0, 118.0, 114.0, 127.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 86.0, 132.0, 87.0, 91.0, 88.0, 90.0, 85.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 108.0, 149.0, 131.0, 95.0, 96.0, 95.0, 95.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 83.0, 85.0, 87.0, 83.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 80.0, 79.0, 85.0, 85.0, 82.0, 66.0, 78.0, 59.0, 57.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 73.0, 79.0, 71.0, 67.0, 70.0, 67.0, 68.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 81.0, 82.0, 81.0, 81.0, 83.0, 83.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 164.0, 136.0, 136.0, 140.0, 137.0, 137.0, 138.0, 176.0, 158.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 197.0, 197.0, 193.0, 193.0, 195.0, 203.0, 196.0, 195.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 69.0, 69.0, 67.0, 69.0, 70.0, 69.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1547.3000000000002, "alertThreshold": 2.0}]} 10:09:35 INFO - Return code: 0 10:09:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:09:35 ERROR - # TBPL SUCCESS # 10:09:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:35 INFO - 2016-04-26 10:09:35.277 screenresolution[1985:15092] starting screenresolution argv=screenresolution get 10:09:35 INFO - 2016-04-26 10:09:35.280 screenresolution[1985:15092] Display 0: 1600x1200x32@60 10:09:35 INFO - 2016-04-26 10:09:35.286 screenresolution[1986:15095] starting screenresolution argv=screenresolution list 10:09:35 INFO - Available Modes on Display 0 10:09:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:35 INFO - Intel Iris: 10:09:35 INFO - Chipset Model: Intel Iris 10:09:35 INFO - Type: GPU 10:09:35 INFO - Bus: Built-In 10:09:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:35 INFO - Vendor: Intel (0x8086) 10:09:35 INFO - Device ID: 0x0a2e 10:09:35 INFO - Revision ID: 0x0009 10:09:35 INFO - Displays: 10:09:35 INFO - Display: 10:09:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:35 INFO - Display Serial Number: 1600x1200 60 10:09:35 INFO - Main Display: Yes 10:09:35 INFO - Mirror: Off 10:09:35 INFO - Online: Yes 10:09:35 INFO - Rotation: Supported 10:09:35 INFO - Return code: 0 10:09:35 INFO - Running post-action listener: _resource_record_post_action 10:09:35 INFO - Running post-run listener: _resource_record_post_run 10:09:36 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 694421504; Read time: 13; Write time: 1963 10:09:36 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 390795776; Write bytes: 384550912; Read time: 29685; Write time: 734 10:09:36 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 296341504; Read time: 13; Write time: 1193 10:09:36 INFO - Running post-run listener: _upload_blobber_files 10:09:36 INFO - Blob upload gear active. 10:09:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:36 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 10:09:36 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'] 10:09:36 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 10:09:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:09:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:38 INFO - (blobuploader) - INFO - Done attempting. 10:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:39 INFO - (blobuploader) - INFO - Done attempting. 10:09:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:39 INFO - Return code: 0 10:09:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4badc11064940f5d2ef192db831c724d541e82818f9a4f5d52b6278af42a11368dc655b680c1bc6a7844f6dd422a06ea1844769500eb9fc5713e9e3d7d517266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9b62e7c402ba4c7321dd40ba855439328c3dadb61274f2e475cfc3ed2fb2a1a308eb4bb6ae1e96db4ae3376493b36793ce18864711b4540916bcb654d4db518"} 10:09:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:39 INFO - Contents: 10:09:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4badc11064940f5d2ef192db831c724d541e82818f9a4f5d52b6278af42a11368dc655b680c1bc6a7844f6dd422a06ea1844769500eb9fc5713e9e3d7d517266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9b62e7c402ba4c7321dd40ba855439328c3dadb61274f2e475cfc3ed2fb2a1a308eb4bb6ae1e96db4ae3376493b36793ce18864711b4540916bcb654d4db518"} 10:09:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:39 INFO - Copying logs to upload dir... 10:09:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.197144 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-26 10:09:39.569614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 10:09:39.577301) ========= 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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/4badc11064940f5d2ef192db831c724d541e82818f9a4f5d52b6278af42a11368dc655b680c1bc6a7844f6dd422a06ea1844769500eb9fc5713e9e3d7d517266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9b62e7c402ba4c7321dd40ba855439328c3dadb61274f2e475cfc3ed2fb2a1a308eb4bb6ae1e96db4ae3376493b36793ce18864711b4540916bcb654d4db518"} build_url:https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/H-qrvz7vSLSzwJdyfVz1uA/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/4badc11064940f5d2ef192db831c724d541e82818f9a4f5d52b6278af42a11368dc655b680c1bc6a7844f6dd422a06ea1844769500eb9fc5713e9e3d7d517266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9b62e7c402ba4c7321dd40ba855439328c3dadb61274f2e475cfc3ed2fb2a1a308eb4bb6ae1e96db4ae3376493b36793ce18864711b4540916bcb654d4db518"}' ========= master_lag: 0.93 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 10:09:40.518636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:09:40.518948) ========= 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.PU9hSa5Wzg/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.9xDLjwmyfG/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005183 ========= master_lag: 0.96 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 10:09:41.487549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 10:09:41.487844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 10:09:41.513216) ========= ========= Total master_lag: 2.47 =========