builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0099 starttime: 1461586031.71 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:11.705490) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:11.705837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:11.706104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:11.737690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:11.738006) ========= 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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-25 05:07:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.85M=0.001s 2016-04-25 05:07:12 (9.85 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.448565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:12.204732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:12.205159) ========= 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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.025895 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:12.253940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:12.254329) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --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 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-25 05:07:12,332 truncating revision to first 12 chars 2016-04-25 05:07:12,332 Setting DEBUG logging. 2016-04-25 05:07:12,332 attempt 1/10 2016-04-25 05:07:12,332 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:07:13,433 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:13.610230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:13.610604) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:13.611040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:13.611358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:13.628584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-25 05:07:13.628945) ========= /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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:13 INFO - MultiFileLogger online at 20160425 05:07:13 in /builds/slave/test 05:07:13 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 05:07:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:13 INFO - {'append_to_log': False, 05:07:13 INFO - 'base_work_dir': '/builds/slave/test', 05:07:13 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:13 INFO - 'branch': 'Fx-Team', 05:07:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:13 INFO - 'config_files': ('talos/mac_config.py',), 05:07:13 INFO - 'default_actions': ('clobber', 05:07:13 INFO - 'read-buildbot-config', 05:07:13 INFO - 'download-and-extract', 05:07:13 INFO - 'populate-webroot', 05:07:13 INFO - 'create-virtualenv', 05:07:13 INFO - 'install', 05:07:13 INFO - 'run-tests'), 05:07:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:13 INFO - 'download_minidump_stackwalk': True, 05:07:13 INFO - 'download_symbols': 'ondemand', 05:07:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:13 INFO - 'installer_path': 'installer.exe', 05:07:13 INFO - 'log_level': 'info', 05:07:13 INFO - 'log_name': 'talos', 05:07:13 INFO - 'log_to_console': True, 05:07:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:13 INFO - 'opt_config_files': (), 05:07:13 INFO - 'pip_index': False, 05:07:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:13 INFO - 'cmd': ('bash', 05:07:13 INFO - '-c', 05:07:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:13 INFO - 'enabled': True, 05:07:13 INFO - 'halt_on_failure': False, 05:07:13 INFO - 'name': 'check_screen_resolution'},), 05:07:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:13 INFO - 'cmd': ('bash', 05:07:13 INFO - '-c', 05:07:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:13 INFO - 'enabled': True, 05:07:13 INFO - 'halt_on_failure': False, 05:07:13 INFO - 'name': 'check_screen_resolution'},), 05:07:13 INFO - 'run_cmd_checks_enabled': True, 05:07:13 INFO - 'sps_profile': False, 05:07:13 INFO - 'sps_profile_interval': 0, 05:07:13 INFO - 'suite': 'dromaeojs', 05:07:13 INFO - 'system_bits': '32', 05:07:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:13 INFO - 'title': 't-yosemite-r7-0099', 05:07:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:13 INFO - 'use_talos_json': True, 05:07:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:13 INFO - 'work_dir': 'build'} 05:07:13 INFO - ##### 05:07:13 INFO - ##### Running clobber step. 05:07:13 INFO - ##### 05:07:13 INFO - Running pre-action listener: _resource_record_pre_action 05:07:13 INFO - Running main action method: clobber 05:07:13 INFO - rmtree: /builds/slave/test/build 05:07:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:15 INFO - Running post-action listener: _resource_record_post_action 05:07:15 INFO - ##### 05:07:15 INFO - ##### Running read-buildbot-config step. 05:07:15 INFO - ##### 05:07:15 INFO - Running pre-action listener: _resource_record_pre_action 05:07:15 INFO - Running main action method: read_buildbot_config 05:07:15 INFO - Using buildbot properties: 05:07:15 INFO - { 05:07:15 INFO - "project": "", 05:07:15 INFO - "product": "firefox", 05:07:15 INFO - "script_repo_revision": "production", 05:07:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:07:15 INFO - "repository": "", 05:07:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:07:15 INFO - "buildid": "20160422035423", 05:07:15 INFO - "pgo_build": "False", 05:07:15 INFO - "basedir": "/builds/slave/test", 05:07:15 INFO - "buildnumber": 718, 05:07:15 INFO - "slavename": "t-yosemite-r7-0099", 05:07:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:07:15 INFO - "platform": "yosemite_r7", 05:07:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:07:15 INFO - "branch": "fx-team", 05:07:15 INFO - "repo_path": "integration/fx-team", 05:07:15 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:07:15 INFO - "stage_platform": "macosx64", 05:07:15 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:07:15 INFO - "slavebuilddir": "test" 05:07:15 INFO - } 05:07:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:07:15 INFO - Running post-action listener: _resource_record_post_action 05:07:15 INFO - ##### 05:07:15 INFO - ##### Running download-and-extract step. 05:07:15 INFO - ##### 05:07:15 INFO - Running pre-action listener: _resource_record_pre_action 05:07:15 INFO - Running main action method: download_and_extract 05:07:15 INFO - mkdir: /builds/slave/test/build/tests 05:07: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')]} 05:07:15 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:07:16 INFO - Downloaded 1199 bytes. 05:07:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:16 INFO - Using the following test package requirements: 05:07:16 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:07:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'jsshell-mac.zip'], 05:07:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:07:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:07:16 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:07:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:07:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:16 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07: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')]} 05:07:16 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:18 INFO - Downloaded 18105795 bytes. 05:07:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:21 INFO - Return code: 0 05:07:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:07:21 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')]} 05:07:21 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:30 INFO - Downloaded 18105795 bytes. 05:07:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:33 INFO - Return code: 0 05:07: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')]} 05:07:33 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:07:34 INFO - Downloaded 10845952 bytes. 05:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:07:34 INFO - Return code: 0 05:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:34 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:07:37 INFO - Downloaded 110035353 bytes. 05:07:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:37 INFO - mkdir: /builds/slave/test/properties 05:07:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:37 INFO - Contents: 05:07:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:38 INFO - Running post-action listener: _resource_record_post_action 05:07:38 INFO - Running post-action listener: set_extra_try_arguments 05:07:38 INFO - ##### 05:07:38 INFO - ##### Running populate-webroot step. 05:07:38 INFO - ##### 05:07:38 INFO - Running pre-action listener: _resource_record_pre_action 05:07:38 INFO - Running main action method: populate_webroot 05:07:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:38 INFO - '--tppagecycles', 05:07:38 INFO - '7'], 05:07:38 INFO - 'tests': ['tsvgm']}}, 05:07:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['damp', 'tps']}, 05:07:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'tests': ['damp', 'tps']}, 05:07:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['dromaeo_dom']}, 05:07:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['a11yr', 05:07:38 INFO - 'ts_paint', 05:07:38 INFO - 'tpaint', 05:07:38 INFO - 'sessionrestore', 05:07:38 INFO - 'sessionrestore_no_auto_restore', 05:07:38 INFO - 'tabpaint']}, 05:07:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['tsvgx', 05:07:38 INFO - 'tsvgr_opacity', 05:07:38 INFO - 'tart', 05:07:38 INFO - 'tscrollx', 05:07:38 INFO - 'cart']}, 05:07:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:38 INFO - 'tsvgr_opacity', 05:07:38 INFO - 'tart', 05:07:38 INFO - 'tscrollx', 05:07:38 INFO - 'cart']}, 05:07:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'talos_options': ['--disable-e10s'], 05:07:38 INFO - 'tests': ['tp5o']}, 05:07:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'tests': ['tp5o']}, 05:07:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'talos_options': ['--disable-e10s', 05:07:38 INFO - '--xperf_path', 05:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:38 INFO - 'tests': ['tp5n']}, 05:07:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:38 INFO - 'talos_options': ['--xperf_path', 05:07:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:38 INFO - 'tests': ['tp5n']}}, 05:07:38 INFO - 'talos.zip': {'path': '', 05:07:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:38 INFO - Running post-action listener: _resource_record_post_action 05:07:38 INFO - ##### 05:07:38 INFO - ##### Running create-virtualenv step. 05:07:38 INFO - ##### 05:07:38 INFO - Running pre-action listener: _resource_record_pre_action 05:07:38 INFO - Running main action method: create_virtualenv 05:07:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:38 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 05:07:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:38 INFO - Using real prefix '/tools/python27' 05:07:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:42 INFO - Installing pip.................done. 05:07:42 INFO - Return code: 0 05:07:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:42 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')]} 05:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:42 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')]} 05:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:42 INFO - 'HOME': '/Users/cltbld', 05:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:42 INFO - 'LOGNAME': 'cltbld', 05:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:42 INFO - 'MOZ_NO_REMOTE': '1', 05:07:42 INFO - 'NO_EM_RESTART': '1', 05:07:42 INFO - 'PAGER': '/bin/cat', 05:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:42 INFO - 'PWD': '/builds/slave/test', 05:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:42 INFO - 'SHELL': '/bin/bash', 05:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:42 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:42 INFO - 'USER': 'cltbld', 05:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:42 INFO - 'XPC_FLAGS': '0x0', 05:07:42 INFO - 'XPC_SERVICE_NAME': '0', 05:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:42 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 05:07:42 INFO - Cleaning up... 05:07:42 INFO - Return code: 0 05:07:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07:42 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')]} 05:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:42 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')]} 05:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:42 INFO - 'HOME': '/Users/cltbld', 05:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:42 INFO - 'LOGNAME': 'cltbld', 05:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:42 INFO - 'MOZ_NO_REMOTE': '1', 05:07:42 INFO - 'NO_EM_RESTART': '1', 05:07:42 INFO - 'PAGER': '/bin/cat', 05:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:42 INFO - 'PWD': '/builds/slave/test', 05:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:42 INFO - 'SHELL': '/bin/bash', 05:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:42 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:42 INFO - 'USER': 'cltbld', 05:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:42 INFO - 'XPC_FLAGS': '0x0', 05:07:42 INFO - 'XPC_SERVICE_NAME': '0', 05:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:43 INFO - Downloading/unpacking psutil>=0.7.1 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:43 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 05:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:45 INFO - Installing collected packages: psutil 05:07:45 INFO - Running setup.py install for psutil 05:07:45 INFO - building 'psutil._psutil_osx' extension 05:07:46 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 05:07:46 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 05:07:46 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 05:07:46 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 05:07:46 INFO - building 'psutil._psutil_posix' extension 05:07:46 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 05:07:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:07:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:07:46 INFO - ^ 05:07:46 INFO - 1 warning generated. 05:07:46 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 05:07:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:47 INFO - Successfully installed psutil 05:07:47 INFO - Cleaning up... 05:07:47 INFO - Return code: 0 05:07:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:07:47 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')]} 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:47 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')]} 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:47 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:47 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 05:07:47 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 05:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:47 INFO - 'HOME': '/Users/cltbld', 05:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:47 INFO - 'LOGNAME': 'cltbld', 05:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:47 INFO - 'MOZ_NO_REMOTE': '1', 05:07:47 INFO - 'NO_EM_RESTART': '1', 05:07:47 INFO - 'PAGER': '/bin/cat', 05:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:47 INFO - 'PWD': '/builds/slave/test', 05:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:47 INFO - 'SHELL': '/bin/bash', 05:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:47 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:47 INFO - 'USER': 'cltbld', 05:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:47 INFO - 'XPC_FLAGS': '0x0', 05:07:47 INFO - 'XPC_SERVICE_NAME': '0', 05:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:07:47 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 05:07:47 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 05:07:47 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 05:07:47 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 05:07:47 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 05:07:47 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 05:07:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:07:49 INFO - Installing collected packages: mozsystemmonitor 05:07:49 INFO - Running setup.py install for mozsystemmonitor 05:07:50 INFO - Successfully installed mozsystemmonitor 05:07:50 INFO - Cleaning up... 05:07:50 INFO - Return code: 0 05:07:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:50 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')]} 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:50 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')]} 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:50 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:50 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 05:07:50 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 05:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:50 INFO - 'HOME': '/Users/cltbld', 05:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:50 INFO - 'LOGNAME': 'cltbld', 05:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:50 INFO - 'MOZ_NO_REMOTE': '1', 05:07:50 INFO - 'NO_EM_RESTART': '1', 05:07:50 INFO - 'PAGER': '/bin/cat', 05:07:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:50 INFO - 'PWD': '/builds/slave/test', 05:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:50 INFO - 'SHELL': '/bin/bash', 05:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:50 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:50 INFO - 'USER': 'cltbld', 05:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:50 INFO - 'XPC_FLAGS': '0x0', 05:07:50 INFO - 'XPC_SERVICE_NAME': '0', 05:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:50 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 05:07:50 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 05:07:50 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 05:07:50 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 05:07:50 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 05:07:50 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 05:07:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:53 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 05:07:53 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 05:07:53 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 05:07:53 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 05:07:53 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 05:07:53 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 05:07:53 INFO - Downloading docopt-0.6.1.tar.gz 05:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:53 INFO - Running setup.py install for blobuploader 05:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:54 INFO - Running setup.py install for requests 05:07:54 INFO - Running setup.py install for docopt 05:07:54 INFO - Successfully installed blobuploader requests docopt 05:07:54 INFO - Cleaning up... 05:07:54 INFO - Return code: 0 05:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:54 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:54 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 05:07:54 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 05:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:54 INFO - 'HOME': '/Users/cltbld', 05:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:54 INFO - 'LOGNAME': 'cltbld', 05:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:54 INFO - 'MOZ_NO_REMOTE': '1', 05:07:54 INFO - 'NO_EM_RESTART': '1', 05:07:54 INFO - 'PAGER': '/bin/cat', 05:07:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:54 INFO - 'PWD': '/builds/slave/test', 05:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:54 INFO - 'SHELL': '/bin/bash', 05:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:54 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:54 INFO - 'USER': 'cltbld', 05:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:54 INFO - 'XPC_FLAGS': '0x0', 05:07:54 INFO - 'XPC_SERVICE_NAME': '0', 05:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-zyYcPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-7pWej_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-9OiGzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-WEvSvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Se2FF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ZwL_zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-2qadC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-zrE9km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:55 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-gF25LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-lR_XxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-RZ7Ib3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-JDBmZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-t1MWbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Vv8Wd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-3jg_Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qap65b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-nkrvPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:56 INFO - Running setup.py install for manifestparser 05:07:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozcrash 05:07:57 INFO - Running setup.py install for mozdebug 05:07:57 INFO - Running setup.py install for mozdevice 05:07:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozfile 05:07:57 INFO - Running setup.py install for mozhttpd 05:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozinfo 05:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozInstall 05:07:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozleak 05:07:58 INFO - Running setup.py install for mozlog 05:07:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for moznetwork 05:07:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozprocess 05:07:58 INFO - Running setup.py install for mozprofile 05:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozrunner 05:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozscreenshot 05:07:59 INFO - Running setup.py install for moztest 05:07:59 INFO - Running setup.py install for mozversion 05:07:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:59 INFO - Cleaning up... 05:07:59 INFO - Return code: 0 05:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:59 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:07:59 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 05:07:59 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 05:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:59 INFO - 'HOME': '/Users/cltbld', 05:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:59 INFO - 'LOGNAME': 'cltbld', 05:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:59 INFO - 'MOZ_NO_REMOTE': '1', 05:07:59 INFO - 'NO_EM_RESTART': '1', 05:07:59 INFO - 'PAGER': '/bin/cat', 05:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:59 INFO - 'PWD': '/builds/slave/test', 05:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:59 INFO - 'SHELL': '/bin/bash', 05:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:07:59 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:59 INFO - 'USER': 'cltbld', 05:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:59 INFO - 'XPC_FLAGS': '0x0', 05:07:59 INFO - 'XPC_SERVICE_NAME': '0', 05:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-S0Ki4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:59 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)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-xJnjIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:59 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)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:59 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-LVXrqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-lBNdis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-lhRac1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-uHdf5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-CCI9M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-_Bx1vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-j7WOYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-1Ff4tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-EoRJbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-puH6Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:00 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)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:00 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Xm2tKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-f6f0Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-mxHc2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Wtv7Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-gjwgpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:01 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)) 05:08:01 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)) 05:08:01 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)) 05:08:01 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)) 05:08:01 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)) 05:08:01 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)) 05:08:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:03 INFO - Downloading blessings-1.6.tar.gz 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:04 INFO - Installing collected packages: blessings 05:08:04 INFO - Running setup.py install for blessings 05:08:04 INFO - Successfully installed blessings 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:04 INFO - Reading from file tmpfile_stdout 05:08:04 INFO - Current package versions: 05:08:04 INFO - blessings == 1.6 05:08:04 INFO - blobuploader == 1.2.4 05:08:04 INFO - docopt == 0.6.1 05:08:04 INFO - manifestparser == 1.1 05:08:04 INFO - mozInstall == 1.12 05:08:04 INFO - mozcrash == 0.17 05:08:04 INFO - mozdebug == 0.1 05:08:04 INFO - mozdevice == 0.48 05:08:04 INFO - mozfile == 1.2 05:08:04 INFO - mozhttpd == 0.7 05:08:04 INFO - mozinfo == 0.9 05:08:04 INFO - mozleak == 0.1 05:08:04 INFO - mozlog == 3.1 05:08:04 INFO - moznetwork == 0.27 05:08:04 INFO - mozprocess == 0.22 05:08:04 INFO - mozprofile == 0.28 05:08:04 INFO - mozrunner == 6.11 05:08:04 INFO - mozscreenshot == 0.1 05:08:04 INFO - mozsystemmonitor == 0.0 05:08:04 INFO - moztest == 0.7 05:08:04 INFO - mozversion == 1.4 05:08:04 INFO - psutil == 3.1.1 05:08:04 INFO - requests == 1.2.3 05:08:04 INFO - wsgiref == 0.1.2 05:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:08:04 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 05:08:04 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 05:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:04 INFO - 'HOME': '/Users/cltbld', 05:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PAGER': '/bin/cat', 05:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:08:04 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - 'XPC_FLAGS': '0x0', 05:08:04 INFO - 'XPC_SERVICE_NAME': '0', 05:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 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)) 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:08:04 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 05:08:04 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 05:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:04 INFO - 'HOME': '/Users/cltbld', 05:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PAGER': '/bin/cat', 05:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:08:04 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - 'XPC_FLAGS': '0x0', 05:08:04 INFO - 'XPC_SERVICE_NAME': '0', 05:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:05 INFO - Downloading/unpacking jsonschema 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:07 INFO - warning: no files found matching '*.txt' 05:08:07 INFO - no previously-included directories found matching 'build' 05:08:07 INFO - no previously-included directories found matching 'dist' 05:08:07 INFO - no previously-included directories found matching '.git*' 05:08:07 INFO - Installing collected packages: jsonschema, functools32 05:08:08 INFO - Running setup.py install for functools32 05:08:08 INFO - warning: no files found matching '*.txt' 05:08:08 INFO - no previously-included directories found matching 'build' 05:08:08 INFO - no previously-included directories found matching 'dist' 05:08:08 INFO - no previously-included directories found matching '.git*' 05:08:08 INFO - Successfully installed jsonschema functools32 05:08:08 INFO - Cleaning up... 05:08:08 INFO - Return code: 0 05:08:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:08 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')]} 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 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')]} 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 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 0x1058a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad58cb23f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, '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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:08:08 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 05:08:08 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 05:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:08 INFO - 'HOME': '/Users/cltbld', 05:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:08 INFO - 'LOGNAME': 'cltbld', 05:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:08 INFO - 'MOZ_NO_REMOTE': '1', 05:08:08 INFO - 'NO_EM_RESTART': '1', 05:08:08 INFO - 'PAGER': '/bin/cat', 05:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:08 INFO - 'PWD': '/builds/slave/test', 05:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:08 INFO - 'SHELL': '/bin/bash', 05:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:08:08 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:08 INFO - 'USER': 'cltbld', 05:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:08 INFO - 'XPC_FLAGS': '0x0', 05:08:08 INFO - 'XPC_SERVICE_NAME': '0', 05:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Downloading/unpacking flake8 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 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 05:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:12 INFO - no previously-included directories found matching 'docs/_build' 05:08:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:12 INFO - Running setup.py install for pep8 05:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:12 INFO - no previously-included directories found matching 'docs/_build' 05:08:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:12 INFO - Cleaning up... 05:08:12 INFO - Return code: 0 05:08:12 INFO - Running post-action listener: _resource_record_post_action 05:08:12 INFO - Running post-action listener: _start_resource_monitoring 05:08:12 INFO - Starting resource monitoring. 05:08:12 INFO - ##### 05:08:12 INFO - ##### Running install step. 05:08:12 INFO - ##### 05:08:12 INFO - Running pre-action listener: _resource_record_pre_action 05:08:12 INFO - Running main action method: install 05:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:12 INFO - Reading from file tmpfile_stdout 05:08:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:12 INFO - Reading from file tmpfile_stdout 05:08:12 INFO - Output received: 05:08:12 INFO - Usage: mozinstall [options] installer 05:08:12 INFO - Options: 05:08:12 INFO - -h, --help show this help message and exit 05:08:12 INFO - -d DEST, --destination=DEST 05:08:12 INFO - Directory to install application into. [default: 05:08:12 INFO - "/builds/slave/test"] 05:08:12 INFO - --app=APP Application being installed. [default: firefox] 05:08:12 INFO - mkdir: /builds/slave/test/build/application 05:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:08:46 INFO - Reading from file tmpfile_stdout 05:08:46 INFO - Output received: 05:08:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:08:46 INFO - Running post-action listener: _resource_record_post_action 05:08:46 INFO - ##### 05:08:46 INFO - ##### Running run-tests step. 05:08:46 INFO - ##### 05:08:46 INFO - Running pre-action listener: _resource_record_pre_action 05:08:46 INFO - Running main action method: run_tests 05:08:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:08:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:08:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:08:46 INFO - 2016-04-25 05:08:46.492 screenresolution[1642:7741] starting screenresolution argv=screenresolution get 05:08:46 INFO - 2016-04-25 05:08:46.495 screenresolution[1642:7741] Display 0: 1600x1200x32@60 05:08:46 INFO - 2016-04-25 05:08:46.501 screenresolution[1643:7743] starting screenresolution argv=screenresolution list 05:08:46 INFO - Available Modes on Display 0 05:08:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:08:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:08:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:08:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:08:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:08:46 INFO - Intel Iris: 05:08:46 INFO - Chipset Model: Intel Iris 05:08:46 INFO - Type: GPU 05:08:46 INFO - Bus: Built-In 05:08:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:08:46 INFO - Vendor: Intel (0x8086) 05:08:46 INFO - Device ID: 0x0a2e 05:08:46 INFO - Revision ID: 0x0009 05:08:46 INFO - Displays: 05:08:46 INFO - Display: 05:08:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:08:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:08:46 INFO - Display Serial Number: 1600x1200 60 05:08:46 INFO - Main Display: Yes 05:08:46 INFO - Mirror: Off 05:08:46 INFO - Online: Yes 05:08:46 INFO - Rotation: Supported 05:08:46 INFO - Return code: 0 05:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:46 INFO - Python 2.7.3 05:08:46 INFO - Return code: 0 05:08:46 INFO - grabbing minidump binary from tooltool 05:08: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')]} 05:08:46 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 0x105740e00>, '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 0x105569db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10573bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:46 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 05:08:46 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 05:08:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:46 INFO - Return code: 0 05:08:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:08:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:08:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:48 INFO - Return code: 0 05:08:48 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 05:08:48 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 05:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ITid9dXdrZ/Render', 05:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:48 INFO - 'HOME': '/Users/cltbld', 05:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:48 INFO - 'LOGNAME': 'cltbld', 05:08:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:48 INFO - 'MOZ_NO_REMOTE': '1', 05:08:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:48 INFO - 'NO_EM_RESTART': '1', 05:08:48 INFO - 'PAGER': '/bin/cat', 05:08:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:48 INFO - 'PWD': '/builds/slave/test', 05:08:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:48 INFO - 'SHELL': '/bin/bash', 05:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xx8sbd8HbI/Listeners', 05:08:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:48 INFO - 'USER': 'cltbld', 05:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:48 INFO - 'XPC_FLAGS': '0x0', 05:08:48 INFO - 'XPC_SERVICE_NAME': '0', 05:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:48 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 05:08:48 INFO - mozversion application_buildid: 20160422035423 05:08:48 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:08:48 INFO - mozversion application_display_name: Nightly 05:08:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:48 INFO - mozversion application_name: Firefox 05:08:48 INFO - mozversion application_remotingname: firefox 05:08:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:48 INFO - mozversion application_vendor: Mozilla 05:08:48 INFO - mozversion application_version: 48.0a1 05:08:48 INFO - mozversion platform_buildid: 20160422035423 05:08:48 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:08:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:48 INFO - mozversion platform_version: 48.0a1 05:08:48 INFO - using testdate: 1461586128 05:08:48 INFO - actual date: 1461586128 05:08:48 INFO - starting webserver on 'localhost:49272' 05:08:48 INFO - SUITE-START | Running 2 tests 05:08:48 INFO - TEST-START | dromaeo_css 05:08:48 INFO - operating with platform_type : mac_ 05:08:48 INFO - Initialising browser for dromaeo_css test... 05:08:48 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpbOjNiF/profile http://localhost:49272/getInfo.html) 05:08:50 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:08:50 INFO - PROCESS | 1661 | colorDepth:24 05:08:50 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:08:50 INFO - PROCESS | 1661 | __metrics 05:08:50 INFO - PROCESS | 1661 | 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" 05:08:50 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:08:51 INFO - TEST-INFO | 1661: exit 0 05:08:51 INFO - Browser initialized. 05:08:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:51 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpbOjNiF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:03 INFO - PROCESS | 1663 | RSS: Main: 238895104 05:09:03 INFO - PROCESS | 1663 | 05:09:54 INFO - PROCESS | 1663 | 1461586194080 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] 05:12:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:12:07 INFO - PROCESS | 1663 | RSS: Main: 414822400 05:12:07 INFO - PROCESS | 1663 | 05:15:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:15:11 INFO - PROCESS | 1663 | RSS: Main: 377077760 05:15:11 INFO - PROCESS | 1663 | 05:18:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:18:14 INFO - PROCESS | 1663 | RSS: Main: 371535872 05:18:14 INFO - PROCESS | 1663 | 05:21:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:21:16 INFO - PROCESS | 1663 | RSS: Main: 376578048 05:21:16 INFO - PROCESS | 1663 | 05:24:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:24:20 INFO - PROCESS | 1663 | RSS: Main: 348254208 05:24:20 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:27:23 INFO - PROCESS | 1663 | RSS: Main: 447795200 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | __start_tp_report 05:27:23 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:27:23 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:27:23 INFO - PROCESS | 1663 | |i|pagename|runs| 05:27:23 INFO - PROCESS | 1663 | |0;dojo.html;2944.8527573621313;3440.449528075507;3457.8962631121067;3471.774334668248;3505.754597178197;5645.971770141144;5699.886002279952;5707.65754054757;5713.8000169994;5725.341585717643;5649.830505084844;5702.657840529571;5714.200011998323;5716.14257861321;5728.971355143219;5114;5134.2812006319145;5140.151874940649;5170.1986192140275;5204;5226.477352264762;5227.2159176123505;5231.869203269911;5232.816851410202;5233.790648374061;5108.182690769478;5149.124648809711;5162.122439185328;5165.380154381461;5273.499017593323;5195.428502864682;5210.791568337262;5226.03318386096;5240.633155679104;5285.788568457296;4640.211164102111;4960.355153830015;5135.691858488465;5171.4311425743135;5177.197534382177;5563.833085007456;5584.329880414376;5620.494155526022;5629.352624448159;5630.5495560355075;6239.688015599202;6289.654069026202;6290.559660823744;6309.4636955858805;6311.400416960381;6067.999840656524;6113.32428171423;6194.1018552310115;6203.31763506014;6217.160683307786;5845.766169353178;5856.326522449887;5859.44335288147;5877.52979761618;5895.204147440127;6207;6215;6222.315545290015;6231.189945307172;6246.718897649616;6067.453929146398;6104.3075792339105;6126.693665316717;6193.1329613854095;6209.751609935552;6210.099535567318;6218.502519798405;6224.408681175281;6237.844053898689;6242.656653883989;6144.846378840475;6223.937760622426;6231.657258850716;6238.282597501255;6245.219347581552;6125.510168486406;6196.907046394308;6220.222472190976;6230.59501132425;6235.812925612239;4132.628063474302;4902.970376220962;4935.728534930541;4937.851864444073;4958.57852082577;4360.018995725936;4397.8240870364825;4435.534268901783;4438.977805110953;4470.7764611769935;5693.003724348223;5696.202531645573;5696.971515142398;5698.943010569924;5712.428757124254;5357.491038351351;6193.349698281706;6253.187085678833;6298.716557754912;6300.401461861115;5691.573132015115;5708.628939118944;5713.914291285634;5721.485066344049;5739.540836733051;5380.515753582118;5387.892242155135;5392.784288628411;5399.541039011728;5401.756920938567;6193.287771906288;6245.437910588069;6246.968765156145;6248.968755156195;6300.936990630035;6188.845278868064;6260.060990851409;6269.153664255449;6300.9684951574945;6304.432601065926;6298.08677741734;6299.874002520016;6326.082718005771;6329.335419780857;6333.778317758856;5915.881682366415;6192.442680158807;6202.627842329294;6203.689815509116;6209.379062093754;6206.06908963659;6256.906146407899;6306;6326.936730632635;6327.3988971047675;6089;6106.175666284995;6131.294901086432;6133.233345831771;6141.232345956755;5975.043992961106;6071.544634152545;6116.082587611894;6118.082287656887;6133.110698948538;4765.451973023147;5846.766129354948;5854.648721076749;5858.648481091148;5868.823935281948;4995.575376092927;5987.850303742442;6056.878862422815;6102.731632724008;6107.522607572365;5755.740991655469;5834.854128646818;5858.384869588632;5880.470757631833;5933.080372542263 05:27:23 INFO - PROCESS | 1663 | |1;ext.html;509.52359543826526;521.3144714700171;528.0916823064329;540.370468404309;544.2462189867033;29803.701962980365;30370.696293037065;37219.62780372195;38393.616063839356;38494;40194.39708404376;40880.386794198035;40910.7954460228;40963.77108686737;41013.97465063375;8781.253593444564;9237.538123093853;9433.433993960367;9681.467519286436;9694.612215511372;8525.531095789729;8803.867941980876;11317.943410282978;11650;11652.941735291353;11376.544938202504;11427.200095993283;11433.656990290305;11440.427978601077;11480.71298217543;8490.193431623986;11260.662180134608;11323.830142547868;11380.886191138065;11382.487788049475;9524.476153811538;11150.776984460346;11354.545818167264;11358.488868000959;11372.37451940143;37264.25471490555;37875;37887.24225515502;37917.43123853117;37921;3140.733037691799;3240.0603824890754;3332.7333813294877;3387.813670248135;3493.2489514754197;26614.201573952618;28062.579061314096;28145.718542814513;28222.858885705646;28524.714752852622;2651.4034342273026;2699.4736026474843;2743.9451210975667;2769.598408230795;2793.064323451626;507399;508657.45671271405;509749;512731;513902;34583.4812477813;58585.41414585885;58978;59066.40933590609;59287.814243714885;34184.97445076652;34289;34363.14092147666;34369.140771480415;34445.31109377849;14741.262936853114;15169.469068582546;15173.393064277527;15196.392144314324;15197.772033419507;11507.367094809866;11829.645110646694;12502.49990000408;12576.182548134342;12645.367731613382;7883;7896.447248692652;7896.644650990719;7966.522008679498;7983.481073730189;3308.1398836302733;3343.398188326076;3344.8662053518074;3352.815595142242;3383.864645414205;1011.9494025298706;1028.7993841201044;1080.287010573018;1101.0255923507752;1126.7915435644431;24239.272821815375;28404.43191136166;28678;29306.267343316587;29501.557476637867;1050.177916569756;1105.3754628634795;1117.1732917640886;1124.8650161980615;1198.1972078707288;12318.384080795924;14967.476138335323;15002.94979351435;15031.549053528412;15455.91808573389;645808;650557;656840;657725;659386;58207.4179258202;58923.70538147282;58981.52546186294;59069.79767124476;59135;1306.4969986555245;1466.1789397937189;1477.460726834719;1527.3127092808502;1552.7437972734372;28228.576571351034;28390.290242744097;28988.27529311784;29008.83964641475;29060;37482.500699972785;44413.77793111143;45045.774771127246;45267.547324526335;45283.09433811371;416925;421974.78025219357;422266;422606;423884;20968.790312096684;23858.880705597054;23880.641790373506;27164.456710865277;27223.319417014733;42642.5735742651;43172.56827431811;43571.782141090356;43813.90465238267;43864.561354386045;35896.64103358933;36008.27983440264;36350.63649363472;36503.63496365002;36689.26621467609;35337.293254135286;35543.64456355404;36018.27963440769;36201.63798362088;36346.8182659085;30466.695333046388;35284.64715352814;35376.823115884254;35466.64533354634;36476.088097797765;28588.999385021423;30024.49877506072;30315;30663.693363066082;31487.685123148476;20352.79647203509;23769.52460950806;23915.880420597787;24247.393815154057;24259 05:27:23 INFO - PROCESS | 1663 | |2;jquery.html;394.96247856453635;395.81594558530276;396.56576049226095;400.39140506430243;408.22029922847366;14830.919788426872;15776.526704198877;18670.626587468243;20397.49006274842;20433.284835030776;19367.418977430665;19868.105935232914;20671.483212919684;20698.896505517452;20711.275105371315;5820.854478638025;5918.4673379395845;6136.079588061782;6147.907781383283;6152.538559608025;4153;4952.504749525055;6028.4574388305045;6124.510039196876;6142.140100385949;6637.303083176269;6653.968634861604;6655.301193374698;6658.76694315699;6659.067730517707;6539.34606539347;6557.836054098661;6648.999999999975;6663.733450661967;6684.799456016327;5622.859428514279;5844.211031510777;5850.590458667895;5862.091375836752;5866.325372582122;25425.618615720778;25474.363140921625;25715.842787074627;25831.225063248134;25877.09430169935;2351.3063646224405;2368.336865677613;2676.183763952013;2739.5342791725457;2905.753010994068;14189.290535473185;14632.853671463256;14862.256887155707;15254.923725381414;15289.311980960772;1575.8889982562266;1649.7277949138377;1695.1863105709206;1728.4123398044599;1762.850157736594;108049.45975270151;111506;121837.39081304625;127152.99999999907;128468;9679.516024198761;10364.170866330676;10993.890061099446;11457.140714446283;11671.649850504498;13608;14236.786448203286;14265.928670356581;15398.230088495531;15448.459303924308;7071.257517960643;7896.763097107096;8014.278714915686;8588.527630980356;8773.692920747742;8570.057293697688;8573.271271941954;8603.440776349642;8690.04409514953;8709.738707838775;4191.11986482842;4553.863384098482;4617.79063550829;4643.419572553431;4693.906121877543;1740.3821643316694;1752.8781579788945;1802.8146982191806;1843.6220574782137;1979.8614097013071;926.7720270641427;945.8061097475002;953.1374106433689;1002.7292630989592;1090.7491277006334;19943.00284985745;20079.598408031758;20187.697184542245;20355.287564935155;20441;889.4707648948994;951.1154626197703;953.1850268020881;1017.2980643356061;1025.7538190834146;9489.430634161972;10507.10689591378;10631.94684026575;10793.730156745987;10806.459677016117;503197;508211;514601;515202;607827;123774;135400;135553.3222333882;142225.28887355703;147554.26222868817;995.2933417273672;1025.3181634213165;1038.190211634926;1048.2190767877828;1049.3441599000626;18297.908510457895;18627.068646567346;18730.531736706693;18815.90592047031;18920.43238702841;37806.43290350702;41983.580164199186;55132;55351;55820.72089639526;68620.6568967152;79273.60363198147;79537;81373;81520.18479815363;5555.694436806015;7372.741954031583;7909.960450197712;8251.051129120227;8299.29455996247;10888.346699198073;12544.811827822772;12658.367081646065;12863.163894346837;12881;10888.638246479135;10923.945380273048;10963.671089867317;10968.177386696188;10998.470351818967;9015.188633023059;10703.839442408214;10769.62306319275;10905.291156074829;11007.449627518432;11180.440977950908;11188.272762270426;11258.493367798304;11315.264507806965;11320.377379243891;8071.273585377109;8100.756977290691;8161.510309381456;8463.449875758057;8526.104759000464;10433.426161561187;10910.945445272722;11128.998390144925;11129.387883666475;11264.15518836107 05:27:23 INFO - PROCESS | 1663 | |3;mootools.html;1230.3540641163383;1389.2012093046499;1578.723723348414;1771.46855943217;1943.3198380566794;7953.403494737896;8676.739697809067;8923.152300531456;8924.643014279422;8929.374943753939;8568.700095496659;8793.956030219855;8801.779955501115;8833.558322083885;8846.292296616271;2426.502566973766;2444.3278098522915;2463.8275320727557;2480.8015358771345;2480.9875950620312;2425.745296743843;2480.1071614218868;2481.057198264657;2481.081999660128;2483.4039830440743;2082.6771850363216;2425.1511970810166;2442.8656423896678;2459.348272707734;2460.9909936925865;2108.8928312635835;2397.496525729599;2420.624803155505;2423.4426082001064;2427.053449154831;2308.134449581407;2381.821363397752;2418.5646583614944;2425;2426.6602675625427;7779.72770953014;8041.919580804176;8750.824983500357;8832.33757468186;8847.071057538995;5182.4299327073995;5377.81177658784;5379.058664733656;5381.48875856793;5388.434214407509;3444.6383129771516;3524.7356448266482;3601.819909004539;3625.655562721537;3657.4696668983115;1001.4341896828341;1027.573556973855;1028.4857571214393;1037.3983089807894;1041.1098510773256;9885.90114098857;11783.410829458493;11797.115216358721;11846.526138954432;11879;4471.932921006188;4503.729776213438;4705.341252224691;4711.481737008926;4723.692959957661;9214.769630759285;9222.86165707515;9233.307501937381;9247.029061948533;9247.12152345526;5285.127953887642;5292.576593872558;5302.443243459458;5309.123994540858;5320.042392369411;4842.685225460334;4884.7313397762755;4955.479674634112;4971.900561988812;4979.153543897546;3644.3804553225486;3673.632636736305;3737.7383583148917;3747.1194269346684;3774.6602805747616;1041.9895801042044;1162.6744511536783;1173.6244401791346;1173.8473998380157;1177.1642134084896;893.1738142218422;900.6802585082332;914.9862752058724;942.4109931292942;945.3099237556622;5818.418158184232;5989.9701897288605;5999.070144127667;6051.455369016721;6116.960116780158;444.3468101890216;452.9252673308867;460.0775445232355;471.7829798292755;480.8509362097761;3891.4357418174204;3909.667678247324;3979.1643754811234;3983.402489626579;3991.5409727881083;10207.438590877573;10450.16398688103;10767.784644307227;10916.07213386855;11023.17326200538;10743.355398676105;10856.620018299322;10865.076468500267;10875.129989600813;10911.23621346514;6797.320267973262;7704.845903081907;8139.941807564978;8224.465409748467;8270.2556769891;5243.868903277448;5400.162974738922;5788.334341550775;6062.333143354139;6142.201513803177;9781.804363912539;9895.50522473859;9974.850377244493;10074.748131296776;10100.797984040424;9850.950745246515;10110.69667909964;10128.898711012796;10255.28213025111;10262.794744105226;7185.281471852982;7530.736424225126;7537.924620753942;7544.773656790305;7544.962275188589;8054.5569993650915;8086.191380862102;8104.83790324202;8194.877076843972;8203.343732501266;7279.272072792678;7403.889416587555;7447.106347238149;7557.35762460197;7574.659140338587;6995.195552511323;7004.649767511706;7087.184973728087;7157.176924653523;7383.409327253699;6961.686724097326;6965.233824279224;6974.197967233833;7009.859802803813;7038.964805175941;4660.650451216105;4703.106409782131;4955.6531042826655;5078.390593128848;5112.130937740668;4949.232868905326;5035.924461133012;5057.165567681292;5121.385433747825;5286.259923610774 05:27:23 INFO - PROCESS | 1663 | |4;prototype.html;276.7205122825946;310.8942959393806;316.3767378264818;330.24044697196445;332.19111463586154;4922.729249891255;5902.016139106107;5942.732577034033;5968.552358573108;5978.28260608727;4695;5573.386927437989;5758.1497158906295;5913.521619595102;5914.467697907187;3843.7309388342687;4361.781910904458;4426.45883293364;4432.335149727534;4456.465224173104;4430.534793846648;4438.400815889846;4444.266695995157;4448.28827387618;4451.176532341511;3595.3708101082207;4056.6957478189106;4333.761643109628;4364.410804541394;4379.824807007732;4309.1381723655395;4320.006398528325;4329.978350108261;4346.4349634547625;4348.412964249849;3716;3725.4411838224214;3734.477173195755;3759.6052414496357;3759.9624003759886;4676.643773305737;5534.252875861747;5599.32808063035;5665.2351932489;5707.686077265748;5002.974985125051;5026.47222041684;5028.79884804611;5029.3964724232965;5038.672486288379;5646.632968857011;6153.938430625746;6180.412860778264;6204.87590248197;6244.814314989762;4018.8191531380867;4144.839444955417;4157.521884983235;4160.209560183555;4169.812358443877;5740.856478588069;5850.742090450531;6167.352427995041;6487.18910136233;6628.304028077031;4206.894827629272;4207.789610519461;4222.501012140708;4252.659787217015;4261.531231564525;4133.6693064554765;4253.383259427365;4283.935740963888;4283.978580107142;4309.913801723948;4982.227754698028;5022.121128802445;5024.698518088926;5033.245013247969;5040.218766091261;5117.130087885069;5405.8107966221;5953.255843019622;6027.30685971119;6321.431071203614;1412.8587141285789;1458.7374272631027;1472.2197235465007;1472.433113251406;1477.2023107522032;952.3952290295712;952.538019060755;958.6021800952666;963.2342287881012;972.8540718892223;4775.880602984953;5743.827685169452;5911.527077833763;5916.467517923322;5941.900748361567;5369.812056578001;6502.934970650327;6503.739850406026;6519.869602608016;6527.430798441015;5269;5646.943530564642;5711.257536520226;5904;5911.940880591225;2866;3006.969930300713;3392.3215356928217;3425.3663072331697;3426.241875290415;6241.907666158495;6532.439820297949;6772.627505487147;6804.65976701163;6812.978053292046;5325.467453254643;5660.462256085665;5731.369549349568;6552.115464412339;6701.396874281338;6117.20476338091;6303.289585478288;6774.864502709918;6808.863822723518;6811.727530898708;5679.3184817820475;5736.942630573641;6572.507061970276;6598.90101648466;6606.075149478981;5553.888922221614;5595.748191331319;6309.936900630935;6349.49204063683;6455.515836312202;5440.42875498067;6835.487338449537;6882.793516194522;6892.724291028503;6896.000079988474;3910.1202229498135;4017.9598204018753;4095.5904409558807;4200.97076216329;4243.193793179286;5378.677279363251;5573.191887176417;6495.935040649533;6531.673416329259;6545.967270163619;6128.785492507741;6286.74853005893;6318.0838778375955;6323.810285691253;6324.93240778213;6148.1699970503405;6286.905696414466;6294.443639343756;6296.527760418078;6304.085907543472;5065.961477897096;6182.1345011699295;6183.690815459299;6191.16419283409;6211.2857021441305;5724.313082430135;6054.27348718139;6125.111858780541;6358.809235722936;6372.936270637234;5636.88726225465;6179.2584889811715;6181.96909015452;6206.224221972254;6211.782587609412 05:27:23 INFO - PROCESS | 1663 | |5;yui.html;653.4249860123092;704.4505285877018;708.709429134055;730.4886579394422;752.8005078654154;12442.564510242144;14641.70716585669;15018.849811501881;15052.322645480952;15064.924675376622;13497;13549.322533873315;13593.116447430935;13595.388207530661;13598.864011359883;695.4505940307164;759.2104211619936;867.3061550759398;903.6114470777596;904.398574947659;898.8786513820648;912.4616476278994;912.7946212102257;913.5980168725739;914.1498406481969;960.812641534901;971.0532231074716;971.2036130373097;974.6198982396871;975.2782940623958;736.8526294741073;916.9358144929857;947.7583216279804;950.3870003847549;954.1460392948272;710.3819676881146;713.6289129652552;715.7816865855912;716.3338095571116;716.373173473211;12972.897303729194;13961.511347102803;14594.270286485633;14658.853411465856;14701.485448009375;12289.201201921847;12403.441845116991;12549.1215614907;12608.180468269626;12868.87131128686;9877.259205559612;9950.601975920954;10058.497075146213;10304.587816487332;10490.475476226158;4044;4141.358089496133;4179.456670632829;4214.157168566299;4268.743875367488;75354;77840.22159778443;78336;78463.21536784673;78502.6074869622;9130.484420993034;9409.905900940903;9481;9737.756556086155;9877.851832222523;17192.828071719123;20740.274090407063;20923.79076209249;20988.685169722467;21076;7297.854042919112;7377.188509263977;7422.96288518554;7450.888236676454;7582.67303221934;3958.386450100239;4044.6966477513715;4045.2314060328445;4050.5139383274195;4054.5742697016976;3562.1806984393734;3627.401478755976;3631.7094632429344;3631.8002509862213;3645.9635403646153;626.9059641053879;642.4186111569037;647.2815175155573;648.9318621544764;652.9477641788741;577.8728679690462;579.8603154360396;608.9421504957022;613.2334581772784;624.1760875644197;7887.487313324616;7993.6802527898235;8143.83712325762;8226.794330141674;8294.401279136559;521.2650163269772;559.2226804741413;577.8815342854705;600.9729562169625;602.9668368239701;3755.417910223865;3854.903627409281;3906.8632597858937;3922.941155882664;3923.7841918694744;90183.19633607291;91451.54274228719;91522.08477915269;91774;92320;67477;69119.30880691129;71224;77782;79755.60122199469;53157.734211328694;58898;62403.6879815598;65851.01223481652;67128.66435667888;7949.364050875801;8234.423590348619;8268.932766808299;8301.6679332826;8374.162583741578;45090.425717984435;45310.546894530635;45552.08895821999;45867.31199032084;46255;63258;66757;67118;67182;67561.2304584979;10725.195610329412;11094.223404361617;11122.388268644978;11140.220184587326;11319.547218111184;11083.559137312097;11171;11895.464704088165;12050.156489045683;12532.498700051896;11153.832692509457;11400.144989126014;11740.354280514654;11773.705657358634;11888.762224755283;11152.498137583665;11686.532538698357;11837.289762614271;11922.4038798058;12114.833013244066;11224.326540407275;11299.661010169708;11351.14866385008;11671.299722016705;11779.35213563228;9723;9842.704718858446;9859.654912078044;9913.107820296207;10290.588376464857;7260.564366138048;7864.4888082274465;8724.825503489768;8876.733697989072;9072.546372681472 05:27:23 INFO - PROCESS | 1663 | __end_tp_report 05:27:23 INFO - PROCESS | 1663 | __start_cc_report 05:27:23 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1715 05:27:23 INFO - PROCESS | 1663 | __end_cc_report 05:27:23 INFO - PROCESS | 1663 | __startTimestamp1461587243481__endTimestamp 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:27:23 INFO - PROCESS | 1663 | Number of tests: 6 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5708.58 Median:5868.82 stddev:657.64 (11.2%) stddev-sans-first:622.90 05:27:23 INFO - PROCESS | 1663 | Values: 2944.9 3440.4 3457.9 3471.8 3505.8 5646.0 5699.9 5707.7 5713.8 5725.3 5649.8 5702.7 5714.2 5716.1 5729.0 5114.0 5134.3 5140.2 5170.2 5204.0 5226.5 5227.2 5231.9 5232.8 5233.8 5108.2 5149.1 5162.1 5165.4 5273.5 5195.4 5210.8 5226.0 5240.6 5285.8 4640.2 4960.4 5135.7 5171.4 5177.2 5563.8 5584.3 5620.5 5629.4 5630.5 6239.7 6289.7 6290.6 6309.5 6311.4 6068.0 6113.3 6194.1 6203.3 6217.2 5845.8 5856.3 5859.4 5877.5 5895.2 6207.0 6215.0 6222.3 6231.2 6246.7 6067.5 6104.3 6126.7 6193.1 6209.8 6210.1 6218.5 6224.4 6237.8 6242.7 6144.8 6223.9 6231.7 6238.3 6245.2 6125.5 6196.9 6220.2 6230.6 6235.8 4132.6 4903.0 4935.7 4937.9 4958.6 4360.0 4397.8 4435.5 4439.0 4470.8 5693.0 5696.2 5697.0 5698.9 5712.4 5357.5 6193.3 6253.2 6298.7 6300.4 5691.6 5708.6 5713.9 5721.5 5739.5 5380.5 5387.9 5392.8 5399.5 5401.8 6193.3 6245.4 6247.0 6249.0 6300.9 6188.8 6260.1 6269.2 6301.0 6304.4 6298.1 6299.9 6326.1 6329.3 6333.8 5915.9 6192.4 6202.6 6203.7 6209.4 6206.1 6256.9 6306.0 6326.9 6327.4 6089.0 6106.2 6131.3 6133.2 6141.2 5975.0 6071.5 6116.1 6118.1 6133.1 4765.5 5846.8 5854.6 5858.6 5868.8 4995.6 5987.9 6056.9 6102.7 6107.5 5755.7 5834.9 5858.4 5880.5 5933.1 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64433.29 Median:3368.34 stddev:143962.67 (4274.0%) stddev-sans-first:144286.52 05:27:23 INFO - PROCESS | 1663 | Values: 509.5 521.3 528.1 540.4 544.2 29803.7 30370.7 37219.6 38393.6 38494.0 40194.4 40880.4 40910.8 40963.8 41014.0 8781.3 9237.5 9433.4 9681.5 9694.6 8525.5 8803.9 11317.9 11650.0 11652.9 11376.5 11427.2 11433.7 11440.4 11480.7 8490.2 11260.7 11323.8 11380.9 11382.5 9524.5 11150.8 11354.5 11358.5 11372.4 37264.3 37875.0 37887.2 37917.4 37921.0 3140.7 3240.1 3332.7 3387.8 3493.2 26614.2 28062.6 28145.7 28222.9 28524.7 2651.4 2699.5 2743.9 2769.6 2793.1 507399.0 508657.5 509749.0 512731.0 513902.0 34583.5 58585.4 58978.0 59066.4 59287.8 34185.0 34289.0 34363.1 34369.1 34445.3 14741.3 15169.5 15173.4 15196.4 15197.8 11507.4 11829.6 12502.5 12576.2 12645.4 7883.0 7896.4 7896.6 7966.5 7983.5 3308.1 3343.4 3344.9 3352.8 3383.9 1011.9 1028.8 1080.3 1101.0 1126.8 24239.3 28404.4 28678.0 29306.3 29501.6 1050.2 1105.4 1117.2 1124.9 1198.2 12318.4 14967.5 15002.9 15031.5 15455.9 645808.0 650557.0 656840.0 657725.0 659386.0 58207.4 58923.7 58981.5 59069.8 59135.0 1306.5 1466.2 1477.5 1527.3 1552.7 28228.6 28390.3 28988.3 29008.8 29060.0 37482.5 44413.8 45045.8 45267.5 45283.1 416925.0 421974.8 422266.0 422606.0 423884.0 20968.8 23858.9 23880.6 27164.5 27223.3 42642.6 43172.6 43571.8 43813.9 43864.6 35896.6 36008.3 36350.6 36503.6 36689.3 35337.3 35543.6 36018.3 36201.6 36346.8 30466.7 35284.6 35376.8 35466.6 36476.1 28589.0 30024.5 30315.0 30663.7 31487.7 20352.8 23769.5 23915.9 24247.4 24259.0 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33334.34 Median:2359.82 stddev:89677.40 (3800.2%) stddev-sans-first:89894.87 05:27:23 INFO - PROCESS | 1663 | Values: 395.0 395.8 396.6 400.4 408.2 14830.9 15776.5 18670.6 20397.5 20433.3 19367.4 19868.1 20671.5 20698.9 20711.3 5820.9 5918.5 6136.1 6147.9 6152.5 4153.0 4952.5 6028.5 6124.5 6142.1 6637.3 6654.0 6655.3 6658.8 6659.1 6539.3 6557.8 6649.0 6663.7 6684.8 5622.9 5844.2 5850.6 5862.1 5866.3 25425.6 25474.4 25715.8 25831.2 25877.1 2351.3 2368.3 2676.2 2739.5 2905.8 14189.3 14632.9 14862.3 15254.9 15289.3 1575.9 1649.7 1695.2 1728.4 1762.9 108049.5 111506.0 121837.4 127153.0 128468.0 9679.5 10364.2 10993.9 11457.1 11671.6 13608.0 14236.8 14265.9 15398.2 15448.5 7071.3 7896.8 8014.3 8588.5 8773.7 8570.1 8573.3 8603.4 8690.0 8709.7 4191.1 4553.9 4617.8 4643.4 4693.9 1740.4 1752.9 1802.8 1843.6 1979.9 926.8 945.8 953.1 1002.7 1090.7 19943.0 20079.6 20187.7 20355.3 20441.0 889.5 951.1 953.2 1017.3 1025.8 9489.4 10507.1 10631.9 10793.7 10806.5 503197.0 508211.0 514601.0 515202.0 607827.0 123774.0 135400.0 135553.3 142225.3 147554.3 995.3 1025.3 1038.2 1048.2 1049.3 18297.9 18627.1 18730.5 18815.9 18920.4 37806.4 41983.6 55132.0 55351.0 55820.7 68620.7 79273.6 79537.0 81373.0 81520.2 5555.7 7372.7 7910.0 8251.1 8299.3 10888.3 12544.8 12658.4 12863.2 12881.0 10888.6 10923.9 10963.7 10968.2 10998.5 9015.2 10703.8 10769.6 10905.3 11007.4 11180.4 11188.3 11258.5 11315.3 11320.4 8071.3 8100.8 8161.5 8463.4 8526.1 10433.4 10910.9 11129.0 11129.4 11264.2 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5653.04 Median:4955.57 stddev:3175.12 (64.1%) stddev-sans-first:3166.63 05:27:23 INFO - PROCESS | 1663 | Values: 1230.4 1389.2 1578.7 1771.5 1943.3 7953.4 8676.7 8923.2 8924.6 8929.4 8568.7 8794.0 8801.8 8833.6 8846.3 2426.5 2444.3 2463.8 2480.8 2481.0 2425.7 2480.1 2481.1 2481.1 2483.4 2082.7 2425.2 2442.9 2459.3 2461.0 2108.9 2397.5 2420.6 2423.4 2427.1 2308.1 2381.8 2418.6 2425.0 2426.7 7779.7 8041.9 8750.8 8832.3 8847.1 5182.4 5377.8 5379.1 5381.5 5388.4 3444.6 3524.7 3601.8 3625.7 3657.5 1001.4 1027.6 1028.5 1037.4 1041.1 9885.9 11783.4 11797.1 11846.5 11879.0 4471.9 4503.7 4705.3 4711.5 4723.7 9214.8 9222.9 9233.3 9247.0 9247.1 5285.1 5292.6 5302.4 5309.1 5320.0 4842.7 4884.7 4955.5 4971.9 4979.2 3644.4 3673.6 3737.7 3747.1 3774.7 1042.0 1162.7 1173.6 1173.8 1177.2 893.2 900.7 915.0 942.4 945.3 5818.4 5990.0 5999.1 6051.5 6117.0 444.3 452.9 460.1 471.8 480.9 3891.4 3909.7 3979.2 3983.4 3991.5 10207.4 10450.2 10767.8 10916.1 11023.2 10743.4 10856.6 10865.1 10875.1 10911.2 6797.3 7704.8 8139.9 8224.5 8270.3 5243.9 5400.2 5788.3 6062.3 6142.2 9781.8 9895.5 9974.9 10074.7 10100.8 9851.0 10110.7 10128.9 10255.3 10262.8 7185.3 7530.7 7537.9 7544.8 7545.0 8054.6 8086.2 8104.8 8194.9 8203.3 7279.3 7403.9 7447.1 7557.4 7574.7 6995.2 7004.6 7087.2 7157.2 7383.4 6961.7 6965.2 6974.2 7009.9 7039.0 4660.7 4703.1 4955.7 5078.4 5112.1 4949.2 5035.9 5057.2 5121.4 5286.3 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5027.07 Median:5653.70 stddev:1580.07 (27.9%) stddev-sans-first:1543.75 05:27:23 INFO - PROCESS | 1663 | Values: 276.7 310.9 316.4 330.2 332.2 4922.7 5902.0 5942.7 5968.6 5978.3 4695.0 5573.4 5758.1 5913.5 5914.5 3843.7 4361.8 4426.5 4432.3 4456.5 4430.5 4438.4 4444.3 4448.3 4451.2 3595.4 4056.7 4333.8 4364.4 4379.8 4309.1 4320.0 4330.0 4346.4 4348.4 3716.0 3725.4 3734.5 3759.6 3760.0 4676.6 5534.3 5599.3 5665.2 5707.7 5003.0 5026.5 5028.8 5029.4 5038.7 5646.6 6153.9 6180.4 6204.9 6244.8 4018.8 4144.8 4157.5 4160.2 4169.8 5740.9 5850.7 6167.4 6487.2 6628.3 4206.9 4207.8 4222.5 4252.7 4261.5 4133.7 4253.4 4283.9 4284.0 4309.9 4982.2 5022.1 5024.7 5033.2 5040.2 5117.1 5405.8 5953.3 6027.3 6321.4 1412.9 1458.7 1472.2 1472.4 1477.2 952.4 952.5 958.6 963.2 972.9 4775.9 5743.8 5911.5 5916.5 5941.9 5369.8 6502.9 6503.7 6519.9 6527.4 5269.0 5646.9 5711.3 5904.0 5911.9 2866.0 3007.0 3392.3 3425.4 3426.2 6241.9 6532.4 6772.6 6804.7 6813.0 5325.5 5660.5 5731.4 6552.1 6701.4 6117.2 6303.3 6774.9 6808.9 6811.7 5679.3 5736.9 6572.5 6598.9 6606.1 5553.9 5595.7 6309.9 6349.5 6455.5 5440.4 6835.5 6882.8 6892.7 6896.0 3910.1 4018.0 4095.6 4201.0 4243.2 5378.7 5573.2 6495.9 6531.7 6546.0 6128.8 6286.7 6318.1 6323.8 6324.9 6148.2 6286.9 6294.4 6296.5 6304.1 5066.0 6182.1 6183.7 6191.2 6211.3 5724.3 6054.3 6125.1 6358.8 6372.9 5636.9 6179.3 6182.0 6206.2 6211.8 05:27:23 INFO - PROCESS | 1663 | 05:27:23 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17569.30 Median:31513.93 stddev:24445.56 (77.6%) stddev-sans-first:24481.14 05:27:23 INFO - PROCESS | 1663 | Values: 653.4 704.5 708.7 730.5 752.8 12442.6 14641.7 15018.8 15052.3 15064.9 13497.0 13549.3 13593.1 13595.4 13598.9 695.5 759.2 867.3 903.6 904.4 898.9 912.5 912.8 913.6 914.1 960.8 971.1 971.2 974.6 975.3 736.9 916.9 947.8 950.4 954.1 710.4 713.6 715.8 716.3 716.4 12972.9 13961.5 14594.3 14658.9 14701.5 12289.2 12403.4 12549.1 12608.2 12868.9 9877.3 9950.6 10058.5 10304.6 10490.5 4044.0 4141.4 4179.5 4214.2 4268.7 75354.0 77840.2 78336.0 78463.2 78502.6 9130.5 9409.9 9481.0 9737.8 9877.9 17192.8 20740.3 20923.8 20988.7 21076.0 7297.9 7377.2 7423.0 7450.9 7582.7 3958.4 4044.7 4045.2 4050.5 4054.6 3562.2 3627.4 3631.7 3631.8 3646.0 626.9 642.4 647.3 648.9 652.9 577.9 579.9 608.9 613.2 624.2 7887.5 7993.7 8143.8 8226.8 8294.4 521.3 559.2 577.9 601.0 603.0 3755.4 3854.9 3906.9 3922.9 3923.8 90183.2 91451.5 91522.1 91774.0 92320.0 67477.0 69119.3 71224.0 77782.0 79755.6 53157.7 58898.0 62403.7 65851.0 67128.7 7949.4 8234.4 8268.9 8301.7 8374.2 45090.4 45310.5 45552.1 45867.3 46255.0 63258.0 66757.0 67118.0 67182.0 67561.2 10725.2 11094.2 11122.4 11140.2 11319.5 11083.6 11171.0 11895.5 12050.2 12532.5 11153.8 11400.1 11740.4 11773.7 11888.8 11152.5 11686.5 11837.3 11922.4 12114.8 11224.3 11299.7 11351.1 11671.3 11779.4 9723.0 9842.7 9859.7 9913.1 10290.6 7260.6 7864.5 8724.8 8876.7 9072.5 05:27:23 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:27:23 INFO - PROCESS | 1663 | 05:27:24 INFO - TEST-INFO | 1663: exit 0 05:27:24 INFO - TEST-OK | dromaeo_css | took 1115948ms 05:27:24 INFO - TEST-START | kraken 05:27:24 INFO - operating with platform_type : mac_ 05:27:24 INFO - Initialising browser for kraken test... 05:27:24 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpaChAKC/profile http://localhost:49272/getInfo.html) 05:27:26 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 05:27:26 INFO - PROCESS | 1670 | colorDepth:24 05:27:26 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 05:27:26 INFO - PROCESS | 1670 | __metrics 05:27:26 INFO - PROCESS | 1670 | 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" 05:27:26 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:27:27 INFO - TEST-INFO | 1670: exit 0 05:27:27 INFO - Browser initialized. 05:27:27 INFO - Running cycle 1/1 for kraken test... 05:27:27 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpaChAKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:38 INFO - PROCESS | 1672 | RSS: Main: 238608384 05:27:38 INFO - PROCESS | 1672 | 05:27:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:42 INFO - PROCESS | 1672 | RSS: Main: 285982720 05:27:42 INFO - PROCESS | 1672 | 05:27:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:27:46 INFO - PROCESS | 1672 | RSS: Main: 299204608 05:27:46 INFO - PROCESS | 1672 | 05:27:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:27:50 INFO - PROCESS | 1672 | RSS: Main: 387371008 05:27:50 INFO - PROCESS | 1672 | 05:27:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:27:52 INFO - PROCESS | 1672 | RSS: Main: 287469568 05:27:52 INFO - PROCESS | 1672 | 05:27:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:55 INFO - PROCESS | 1672 | RSS: Main: 292012032 05:27:55 INFO - PROCESS | 1672 | 05:27:58 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:58 INFO - PROCESS | 1672 | RSS: Main: 328552448 05:27:58 INFO - PROCESS | 1672 | 05:28:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:02 INFO - PROCESS | 1672 | RSS: Main: 330792960 05:28:02 INFO - PROCESS | 1672 | 05:28:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:28:05 INFO - PROCESS | 1672 | RSS: Main: 327446528 05:28:05 INFO - PROCESS | 1672 | 05:28:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:08 INFO - PROCESS | 1672 | RSS: Main: 320081920 05:28:08 INFO - PROCESS | 1672 | 05:28:10 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:10 INFO - PROCESS | 1672 | RSS: Main: 327290880 05:28:10 INFO - PROCESS | 1672 | 05:28:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:13 INFO - PROCESS | 1672 | RSS: Main: 330010624 05:28:13 INFO - PROCESS | 1672 | 05:28:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:16 INFO - PROCESS | 1672 | RSS: Main: 334753792 05:28:16 INFO - PROCESS | 1672 | 05:28:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:20 INFO - PROCESS | 1672 | RSS: Main: 332300288 05:28:20 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:28:22 INFO - PROCESS | 1672 | RSS: Main: 397041664 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | __start_tp_report 05:28:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:28:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:28:22 INFO - PROCESS | 1672 | |i|pagename|runs| 05:28:22 INFO - PROCESS | 1672 | |0;ai-astar;113;109;111;112;114;117;164;167;113;112 05:28:22 INFO - PROCESS | 1672 | |1;audio-beat-detection;153;121;140;168;117;138;143;115;175;121 05:28:22 INFO - PROCESS | 1672 | |2;audio-dft;189;184;184;183;187;183;184;183;187;181 05:28:22 INFO - PROCESS | 1672 | |3;audio-fft;74;73;86;92;57;58;57;79;85;55 05:28:22 INFO - PROCESS | 1672 | |4;audio-oscillator;92;92;135;77;78;78;127;80;78;128 05:28:22 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;87;84;89;83;86;84;86;84;86;87 05:28:22 INFO - PROCESS | 1672 | |6;imaging-darkroom;92;93;92;93;100;135;93;99;92;93 05:28:22 INFO - PROCESS | 1672 | |7;imaging-desaturate;124;127;99;119;139;138;104;84;84;85 05:28:22 INFO - PROCESS | 1672 | |8;json-parse-financial;60;59;61;79;86;85;87;78;60;61 05:28:22 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;64;70;74;75;71;66;66;66;67;68 05:28:22 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;81;81;82;82;81;80;81;80;83;82 05:28:22 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;140;138;136;140;138;133;138;134;177;146 05:28:22 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;170;168;171;171;170;170;168;172;173;167 05:28:22 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;69;68;67;67;69;67;70;68;66 05:28:22 INFO - PROCESS | 1672 | __end_tp_report 05:28:22 INFO - PROCESS | 1672 | __start_cc_report 05:28:22 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2008 05:28:22 INFO - PROCESS | 1672 | __end_cc_report 05:28:22 INFO - PROCESS | 1672 | __startTimestamp1461587302322__endTimestamp 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:28:22 INFO - PROCESS | 1672 | Number of tests: 14 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:123.20 Median:113.50 stddev:22.40 (19.7%) stddev-sans-first:23.45 05:28:22 INFO - PROCESS | 1672 | Values: 113.0 109.0 111.0 112.0 114.0 117.0 164.0 167.0 113.0 112.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:141.50 stddev:21.24 (15.0%) stddev-sans-first:21.92 05:28:22 INFO - PROCESS | 1672 | Values: 153.0 121.0 140.0 168.0 117.0 138.0 143.0 115.0 175.0 121.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:184.50 Median:184.00 stddev:2.42 (1.3%) stddev-sans-first:1.94 05:28:22 INFO - PROCESS | 1672 | Values: 189.0 184.0 184.0 183.0 187.0 183.0 184.0 183.0 187.0 181.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:71.60 Median:76.50 stddev:13.95 (18.2%) stddev-sans-first:14.77 05:28:22 INFO - PROCESS | 1672 | Values: 74.0 73.0 86.0 92.0 57.0 58.0 57.0 79.0 85.0 55.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:78.00 stddev:23.86 (30.6%) stddev-sans-first:25.25 05:28:22 INFO - PROCESS | 1672 | Values: 92.0 92.0 135.0 77.0 78.0 78.0 127.0 80.0 78.0 128.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:1.84 (2.1%) stddev-sans-first:1.88 05:28:22 INFO - PROCESS | 1672 | Values: 87.0 84.0 89.0 83.0 86.0 84.0 86.0 84.0 86.0 87.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:93.00 stddev:13.26 (14.3%) stddev-sans-first:13.87 05:28:22 INFO - PROCESS | 1672 | Values: 92.0 93.0 92.0 93.0 100.0 135.0 93.0 99.0 92.0 93.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:111.50 stddev:21.92 (19.7%) stddev-sans-first:22.68 05:28:22 INFO - PROCESS | 1672 | Values: 124.0 127.0 99.0 119.0 139.0 138.0 104.0 84.0 84.0 85.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:78.50 stddev:12.35 (15.7%) stddev-sans-first:12.36 05:28:22 INFO - PROCESS | 1672 | Values: 60.0 59.0 61.0 79.0 86.0 85.0 87.0 78.0 60.0 61.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:3.68 (5.3%) stddev-sans-first:3.49 05:28:22 INFO - PROCESS | 1672 | Values: 64.0 70.0 74.0 75.0 71.0 66.0 66.0 66.0 67.0 68.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:0.95 (1.2%) stddev-sans-first:1.00 05:28:22 INFO - PROCESS | 1672 | Values: 81.0 81.0 82.0 82.0 81.0 80.0 81.0 80.0 83.0 82.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:139.00 stddev:12.81 (9.2%) stddev-sans-first:13.57 05:28:22 INFO - PROCESS | 1672 | Values: 140.0 138.0 136.0 140.0 138.0 133.0 138.0 134.0 177.0 146.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.50 stddev:1.89 (1.1%) stddev-sans-first:2.00 05:28:22 INFO - PROCESS | 1672 | Values: 170.0 168.0 171.0 171.0 170.0 170.0 168.0 172.0 173.0 167.0 05:28:22 INFO - PROCESS | 1672 | 05:28:22 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 05:28:22 INFO - PROCESS | 1672 | Values: 68.0 69.0 68.0 67.0 67.0 69.0 67.0 70.0 68.0 66.0 05:28:22 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:28:22 INFO - PROCESS | 1672 | 05:28:23 INFO - TEST-INFO | 1672: exit 0 05:28:23 INFO - TEST-OK | kraken | took 58921ms 05:28:23 INFO - SUITE-END | took 1174s 05:28:23 INFO - Completed test suite (00:19:35) 05:28:23 INFO - javascript benchmark 05:28:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.8527573621313, 3440.449528075507, 3457.8962631121067, 3471.774334668248, 3505.754597178197, 5645.971770141144, 5699.886002279952, 5707.65754054757, 5713.8000169994, 5725.341585717643, 5649.830505084844, 5702.657840529571, 5714.200011998323, 5716.14257861321, 5728.971355143219, 5114.0, 5134.2812006319145, 5140.151874940649, 5170.1986192140275, 5204.0, 5226.477352264762, 5227.2159176123505, 5231.869203269911, 5232.816851410202, 5233.790648374061, 5108.182690769478, 5149.124648809711, 5162.122439185328, 5165.380154381461, 5273.499017593323, 5195.428502864682, 5210.791568337262, 5226.03318386096, 5240.633155679104, 5285.788568457296, 4640.211164102111, 4960.355153830015, 5135.691858488465, 5171.4311425743135, 5177.197534382177, 5563.833085007456, 5584.329880414376, 5620.494155526022, 5629.352624448159, 5630.5495560355075, 6239.688015599202, 6289.654069026202, 6290.559660823744, 6309.4636955858805, 6311.400416960381, 6067.999840656524, 6113.32428171423, 6194.1018552310115, 6203.31763506014, 6217.160683307786, 5845.766169353178, 5856.326522449887, 5859.44335288147, 5877.52979761618, 5895.204147440127, 6207.0, 6215.0, 6222.315545290015, 6231.189945307172, 6246.718897649616, 6067.453929146398, 6104.3075792339105, 6126.693665316717, 6193.1329613854095, 6209.751609935552, 6210.099535567318, 6218.502519798405, 6224.408681175281, 6237.844053898689, 6242.656653883989, 6144.846378840475, 6223.937760622426, 6231.657258850716, 6238.282597501255, 6245.219347581552, 6125.510168486406, 6196.907046394308, 6220.222472190976, 6230.59501132425, 6235.812925612239, 4132.628063474302, 4902.970376220962, 4935.728534930541, 4937.851864444073, 4958.57852082577, 4360.018995725936, 4397.8240870364825, 4435.534268901783, 4438.977805110953, 4470.7764611769935, 5693.003724348223, 5696.202531645573, 5696.971515142398, 5698.943010569924, 5712.428757124254, 5357.491038351351, 6193.349698281706, 6253.187085678833, 6298.716557754912, 6300.401461861115, 5691.573132015115, 5708.628939118944, 5713.914291285634, 5721.485066344049, 5739.540836733051, 5380.515753582118, 5387.892242155135, 5392.784288628411, 5399.541039011728, 5401.756920938567, 6193.287771906288, 6245.437910588069, 6246.968765156145, 6248.968755156195, 6300.936990630035, 6188.845278868064, 6260.060990851409, 6269.153664255449, 6300.9684951574945, 6304.432601065926, 6298.08677741734, 6299.874002520016, 6326.082718005771, 6329.335419780857, 6333.778317758856, 5915.881682366415, 6192.442680158807, 6202.627842329294, 6203.689815509116, 6209.379062093754, 6206.06908963659, 6256.906146407899, 6306.0, 6326.936730632635, 6327.3988971047675, 6089.0, 6106.175666284995, 6131.294901086432, 6133.233345831771, 6141.232345956755, 5975.043992961106, 6071.544634152545, 6116.082587611894, 6118.082287656887, 6133.110698948538, 4765.451973023147, 5846.766129354948, 5854.648721076749, 5858.648481091148, 5868.823935281948, 4995.575376092927, 5987.850303742442, 6056.878862422815, 6102.731632724008, 6107.522607572365, 5755.740991655469, 5834.854128646818, 5858.384869588632, 5880.470757631833, 5933.080372542263], "value": 5666.384005636994, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.52359543826526, 521.3144714700171, 528.0916823064329, 540.370468404309, 544.2462189867033, 29803.701962980365, 30370.696293037065, 37219.62780372195, 38393.616063839356, 38494.0, 40194.39708404376, 40880.386794198035, 40910.7954460228, 40963.77108686737, 41013.97465063375, 8781.253593444564, 9237.538123093853, 9433.433993960367, 9681.467519286436, 9694.612215511372, 8525.531095789729, 8803.867941980876, 11317.943410282978, 11650.0, 11652.941735291353, 11376.544938202504, 11427.200095993283, 11433.656990290305, 11440.427978601077, 11480.71298217543, 8490.193431623986, 11260.662180134608, 11323.830142547868, 11380.886191138065, 11382.487788049475, 9524.476153811538, 11150.776984460346, 11354.545818167264, 11358.488868000959, 11372.37451940143, 37264.25471490555, 37875.0, 37887.24225515502, 37917.43123853117, 37921.0, 3140.733037691799, 3240.0603824890754, 3332.7333813294877, 3387.813670248135, 3493.2489514754197, 26614.201573952618, 28062.579061314096, 28145.718542814513, 28222.858885705646, 28524.714752852622, 2651.4034342273026, 2699.4736026474843, 2743.9451210975667, 2769.598408230795, 2793.064323451626, 507399.0, 508657.45671271405, 509749.0, 512731.0, 513902.0, 34583.4812477813, 58585.41414585885, 58978.0, 59066.40933590609, 59287.814243714885, 34184.97445076652, 34289.0, 34363.14092147666, 34369.140771480415, 34445.31109377849, 14741.262936853114, 15169.469068582546, 15173.393064277527, 15196.392144314324, 15197.772033419507, 11507.367094809866, 11829.645110646694, 12502.49990000408, 12576.182548134342, 12645.367731613382, 7883.0, 7896.447248692652, 7896.644650990719, 7966.522008679498, 7983.481073730189, 3308.1398836302733, 3343.398188326076, 3344.8662053518074, 3352.815595142242, 3383.864645414205, 1011.9494025298706, 1028.7993841201044, 1080.287010573018, 1101.0255923507752, 1126.7915435644431, 24239.272821815375, 28404.43191136166, 28678.0, 29306.267343316587, 29501.557476637867, 1050.177916569756, 1105.3754628634795, 1117.1732917640886, 1124.8650161980615, 1198.1972078707288, 12318.384080795924, 14967.476138335323, 15002.94979351435, 15031.549053528412, 15455.91808573389, 645808.0, 650557.0, 656840.0, 657725.0, 659386.0, 58207.4179258202, 58923.70538147282, 58981.52546186294, 59069.79767124476, 59135.0, 1306.4969986555245, 1466.1789397937189, 1477.460726834719, 1527.3127092808502, 1552.7437972734372, 28228.576571351034, 28390.290242744097, 28988.27529311784, 29008.83964641475, 29060.0, 37482.500699972785, 44413.77793111143, 45045.774771127246, 45267.547324526335, 45283.09433811371, 416925.0, 421974.78025219357, 422266.0, 422606.0, 423884.0, 20968.790312096684, 23858.880705597054, 23880.641790373506, 27164.456710865277, 27223.319417014733, 42642.5735742651, 43172.56827431811, 43571.782141090356, 43813.90465238267, 43864.561354386045, 35896.64103358933, 36008.27983440264, 36350.63649363472, 36503.63496365002, 36689.26621467609, 35337.293254135286, 35543.64456355404, 36018.27963440769, 36201.63798362088, 36346.8182659085, 30466.695333046388, 35284.64715352814, 35376.823115884254, 35466.64533354634, 36476.088097797765, 28588.999385021423, 30024.49877506072, 30315.0, 30663.693363066082, 31487.685123148476, 20352.79647203509, 23769.52460950806, 23915.880420597787, 24247.393815154057, 24259.0], "value": 18168.266739746712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.96247856453635, 395.81594558530276, 396.56576049226095, 400.39140506430243, 408.22029922847366, 14830.919788426872, 15776.526704198877, 18670.626587468243, 20397.49006274842, 20433.284835030776, 19367.418977430665, 19868.105935232914, 20671.483212919684, 20698.896505517452, 20711.275105371315, 5820.854478638025, 5918.4673379395845, 6136.079588061782, 6147.907781383283, 6152.538559608025, 4153.0, 4952.504749525055, 6028.4574388305045, 6124.510039196876, 6142.140100385949, 6637.303083176269, 6653.968634861604, 6655.301193374698, 6658.76694315699, 6659.067730517707, 6539.34606539347, 6557.836054098661, 6648.999999999975, 6663.733450661967, 6684.799456016327, 5622.859428514279, 5844.211031510777, 5850.590458667895, 5862.091375836752, 5866.325372582122, 25425.618615720778, 25474.363140921625, 25715.842787074627, 25831.225063248134, 25877.09430169935, 2351.3063646224405, 2368.336865677613, 2676.183763952013, 2739.5342791725457, 2905.753010994068, 14189.290535473185, 14632.853671463256, 14862.256887155707, 15254.923725381414, 15289.311980960772, 1575.8889982562266, 1649.7277949138377, 1695.1863105709206, 1728.4123398044599, 1762.850157736594, 108049.45975270151, 111506.0, 121837.39081304625, 127152.99999999907, 128468.0, 9679.516024198761, 10364.170866330676, 10993.890061099446, 11457.140714446283, 11671.649850504498, 13608.0, 14236.786448203286, 14265.928670356581, 15398.230088495531, 15448.459303924308, 7071.257517960643, 7896.763097107096, 8014.278714915686, 8588.527630980356, 8773.692920747742, 8570.057293697688, 8573.271271941954, 8603.440776349642, 8690.04409514953, 8709.738707838775, 4191.11986482842, 4553.863384098482, 4617.79063550829, 4643.419572553431, 4693.906121877543, 1740.3821643316694, 1752.8781579788945, 1802.8146982191806, 1843.6220574782137, 1979.8614097013071, 926.7720270641427, 945.8061097475002, 953.1374106433689, 1002.7292630989592, 1090.7491277006334, 19943.00284985745, 20079.598408031758, 20187.697184542245, 20355.287564935155, 20441.0, 889.4707648948994, 951.1154626197703, 953.1850268020881, 1017.2980643356061, 1025.7538190834146, 9489.430634161972, 10507.10689591378, 10631.94684026575, 10793.730156745987, 10806.459677016117, 503197.0, 508211.0, 514601.0, 515202.0, 607827.0, 123774.0, 135400.0, 135553.3222333882, 142225.28887355703, 147554.26222868817, 995.2933417273672, 1025.3181634213165, 1038.190211634926, 1048.2190767877828, 1049.3441599000626, 18297.908510457895, 18627.068646567346, 18730.531736706693, 18815.90592047031, 18920.43238702841, 37806.43290350702, 41983.580164199186, 55132.0, 55351.0, 55820.72089639526, 68620.6568967152, 79273.60363198147, 79537.0, 81373.0, 81520.18479815363, 5555.694436806015, 7372.741954031583, 7909.960450197712, 8251.051129120227, 8299.29455996247, 10888.346699198073, 12544.811827822772, 12658.367081646065, 12863.163894346837, 12881.0, 10888.638246479135, 10923.945380273048, 10963.671089867317, 10968.177386696188, 10998.470351818967, 9015.188633023059, 10703.839442408214, 10769.62306319275, 10905.291156074829, 11007.449627518432, 11180.440977950908, 11188.272762270426, 11258.493367798304, 11315.264507806965, 11320.377379243891, 8071.273585377109, 8100.756977290691, 8161.510309381456, 8463.449875758057, 8526.104759000464, 10433.426161561187, 10910.945445272722, 11128.998390144925, 11129.387883666475, 11264.15518836107], "value": 9636.344010991272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3540641163383, 1389.2012093046499, 1578.723723348414, 1771.46855943217, 1943.3198380566794, 7953.403494737896, 8676.739697809067, 8923.152300531456, 8924.643014279422, 8929.374943753939, 8568.700095496659, 8793.956030219855, 8801.779955501115, 8833.558322083885, 8846.292296616271, 2426.502566973766, 2444.3278098522915, 2463.8275320727557, 2480.8015358771345, 2480.9875950620312, 2425.745296743843, 2480.1071614218868, 2481.057198264657, 2481.081999660128, 2483.4039830440743, 2082.6771850363216, 2425.1511970810166, 2442.8656423896678, 2459.348272707734, 2460.9909936925865, 2108.8928312635835, 2397.496525729599, 2420.624803155505, 2423.4426082001064, 2427.053449154831, 2308.134449581407, 2381.821363397752, 2418.5646583614944, 2425.0, 2426.6602675625427, 7779.72770953014, 8041.919580804176, 8750.824983500357, 8832.33757468186, 8847.071057538995, 5182.4299327073995, 5377.81177658784, 5379.058664733656, 5381.48875856793, 5388.434214407509, 3444.6383129771516, 3524.7356448266482, 3601.819909004539, 3625.655562721537, 3657.4696668983115, 1001.4341896828341, 1027.573556973855, 1028.4857571214393, 1037.3983089807894, 1041.1098510773256, 9885.90114098857, 11783.410829458493, 11797.115216358721, 11846.526138954432, 11879.0, 4471.932921006188, 4503.729776213438, 4705.341252224691, 4711.481737008926, 4723.692959957661, 9214.769630759285, 9222.86165707515, 9233.307501937381, 9247.029061948533, 9247.12152345526, 5285.127953887642, 5292.576593872558, 5302.443243459458, 5309.123994540858, 5320.042392369411, 4842.685225460334, 4884.7313397762755, 4955.479674634112, 4971.900561988812, 4979.153543897546, 3644.3804553225486, 3673.632636736305, 3737.7383583148917, 3747.1194269346684, 3774.6602805747616, 1041.9895801042044, 1162.6744511536783, 1173.6244401791346, 1173.8473998380157, 1177.1642134084896, 893.1738142218422, 900.6802585082332, 914.9862752058724, 942.4109931292942, 945.3099237556622, 5818.418158184232, 5989.9701897288605, 5999.070144127667, 6051.455369016721, 6116.960116780158, 444.3468101890216, 452.9252673308867, 460.0775445232355, 471.7829798292755, 480.8509362097761, 3891.4357418174204, 3909.667678247324, 3979.1643754811234, 3983.402489626579, 3991.5409727881083, 10207.438590877573, 10450.16398688103, 10767.784644307227, 10916.07213386855, 11023.17326200538, 10743.355398676105, 10856.620018299322, 10865.076468500267, 10875.129989600813, 10911.23621346514, 6797.320267973262, 7704.845903081907, 8139.941807564978, 8224.465409748467, 8270.2556769891, 5243.868903277448, 5400.162974738922, 5788.334341550775, 6062.333143354139, 6142.201513803177, 9781.804363912539, 9895.50522473859, 9974.850377244493, 10074.748131296776, 10100.797984040424, 9850.950745246515, 10110.69667909964, 10128.898711012796, 10255.28213025111, 10262.794744105226, 7185.281471852982, 7530.736424225126, 7537.924620753942, 7544.773656790305, 7544.962275188589, 8054.5569993650915, 8086.191380862102, 8104.83790324202, 8194.877076843972, 8203.343732501266, 7279.272072792678, 7403.889416587555, 7447.106347238149, 7557.35762460197, 7574.659140338587, 6995.195552511323, 7004.649767511706, 7087.184973728087, 7157.176924653523, 7383.409327253699, 6961.686724097326, 6965.233824279224, 6974.197967233833, 7009.859802803813, 7038.964805175941, 4660.650451216105, 4703.106409782131, 4955.6531042826655, 5078.390593128848, 5112.130937740668, 4949.232868905326, 5035.924461133012, 5057.165567681292, 5121.385433747825, 5286.259923610774], "value": 4471.955452175942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.7205122825946, 310.8942959393806, 316.3767378264818, 330.24044697196445, 332.19111463586154, 4922.729249891255, 5902.016139106107, 5942.732577034033, 5968.552358573108, 5978.28260608727, 4695.0, 5573.386927437989, 5758.1497158906295, 5913.521619595102, 5914.467697907187, 3843.7309388342687, 4361.781910904458, 4426.45883293364, 4432.335149727534, 4456.465224173104, 4430.534793846648, 4438.400815889846, 4444.266695995157, 4448.28827387618, 4451.176532341511, 3595.3708101082207, 4056.6957478189106, 4333.761643109628, 4364.410804541394, 4379.824807007732, 4309.1381723655395, 4320.006398528325, 4329.978350108261, 4346.4349634547625, 4348.412964249849, 3716.0, 3725.4411838224214, 3734.477173195755, 3759.6052414496357, 3759.9624003759886, 4676.643773305737, 5534.252875861747, 5599.32808063035, 5665.2351932489, 5707.686077265748, 5002.974985125051, 5026.47222041684, 5028.79884804611, 5029.3964724232965, 5038.672486288379, 5646.632968857011, 6153.938430625746, 6180.412860778264, 6204.87590248197, 6244.814314989762, 4018.8191531380867, 4144.839444955417, 4157.521884983235, 4160.209560183555, 4169.812358443877, 5740.856478588069, 5850.742090450531, 6167.352427995041, 6487.18910136233, 6628.304028077031, 4206.894827629272, 4207.789610519461, 4222.501012140708, 4252.659787217015, 4261.531231564525, 4133.6693064554765, 4253.383259427365, 4283.935740963888, 4283.978580107142, 4309.913801723948, 4982.227754698028, 5022.121128802445, 5024.698518088926, 5033.245013247969, 5040.218766091261, 5117.130087885069, 5405.8107966221, 5953.255843019622, 6027.30685971119, 6321.431071203614, 1412.8587141285789, 1458.7374272631027, 1472.2197235465007, 1472.433113251406, 1477.2023107522032, 952.3952290295712, 952.538019060755, 958.6021800952666, 963.2342287881012, 972.8540718892223, 4775.880602984953, 5743.827685169452, 5911.527077833763, 5916.467517923322, 5941.900748361567, 5369.812056578001, 6502.934970650327, 6503.739850406026, 6519.869602608016, 6527.430798441015, 5269.0, 5646.943530564642, 5711.257536520226, 5904.0, 5911.940880591225, 2866.0, 3006.969930300713, 3392.3215356928217, 3425.3663072331697, 3426.241875290415, 6241.907666158495, 6532.439820297949, 6772.627505487147, 6804.65976701163, 6812.978053292046, 5325.467453254643, 5660.462256085665, 5731.369549349568, 6552.115464412339, 6701.396874281338, 6117.20476338091, 6303.289585478288, 6774.864502709918, 6808.863822723518, 6811.727530898708, 5679.3184817820475, 5736.942630573641, 6572.507061970276, 6598.90101648466, 6606.075149478981, 5553.888922221614, 5595.748191331319, 6309.936900630935, 6349.49204063683, 6455.515836312202, 5440.42875498067, 6835.487338449537, 6882.793516194522, 6892.724291028503, 6896.000079988474, 3910.1202229498135, 4017.9598204018753, 4095.5904409558807, 4200.97076216329, 4243.193793179286, 5378.677279363251, 5573.191887176417, 6495.935040649533, 6531.673416329259, 6545.967270163619, 6128.785492507741, 6286.74853005893, 6318.0838778375955, 6323.810285691253, 6324.93240778213, 6148.1699970503405, 6286.905696414466, 6294.443639343756, 6296.527760418078, 6304.085907543472, 5065.961477897096, 6182.1345011699295, 6183.690815459299, 6191.16419283409, 6211.2857021441305, 5724.313082430135, 6054.27348718139, 6125.111858780541, 6358.809235722936, 6372.936270637234, 5636.88726225465, 6179.2584889811715, 6181.96909015452, 6206.224221972254, 6211.782587609412], "value": 4514.949227216356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.4249860123092, 704.4505285877018, 708.709429134055, 730.4886579394422, 752.8005078654154, 12442.564510242144, 14641.70716585669, 15018.849811501881, 15052.322645480952, 15064.924675376622, 13497.0, 13549.322533873315, 13593.116447430935, 13595.388207530661, 13598.864011359883, 695.4505940307164, 759.2104211619936, 867.3061550759398, 903.6114470777596, 904.398574947659, 898.8786513820648, 912.4616476278994, 912.7946212102257, 913.5980168725739, 914.1498406481969, 960.812641534901, 971.0532231074716, 971.2036130373097, 974.6198982396871, 975.2782940623958, 736.8526294741073, 916.9358144929857, 947.7583216279804, 950.3870003847549, 954.1460392948272, 710.3819676881146, 713.6289129652552, 715.7816865855912, 716.3338095571116, 716.373173473211, 12972.897303729194, 13961.511347102803, 14594.270286485633, 14658.853411465856, 14701.485448009375, 12289.201201921847, 12403.441845116991, 12549.1215614907, 12608.180468269626, 12868.87131128686, 9877.259205559612, 9950.601975920954, 10058.497075146213, 10304.587816487332, 10490.475476226158, 4044.0, 4141.358089496133, 4179.456670632829, 4214.157168566299, 4268.743875367488, 75354.0, 77840.22159778443, 78336.0, 78463.21536784673, 78502.6074869622, 9130.484420993034, 9409.905900940903, 9481.0, 9737.756556086155, 9877.851832222523, 17192.828071719123, 20740.274090407063, 20923.79076209249, 20988.685169722467, 21076.0, 7297.854042919112, 7377.188509263977, 7422.96288518554, 7450.888236676454, 7582.67303221934, 3958.386450100239, 4044.6966477513715, 4045.2314060328445, 4050.5139383274195, 4054.5742697016976, 3562.1806984393734, 3627.401478755976, 3631.7094632429344, 3631.8002509862213, 3645.9635403646153, 626.9059641053879, 642.4186111569037, 647.2815175155573, 648.9318621544764, 652.9477641788741, 577.8728679690462, 579.8603154360396, 608.9421504957022, 613.2334581772784, 624.1760875644197, 7887.487313324616, 7993.6802527898235, 8143.83712325762, 8226.794330141674, 8294.401279136559, 521.2650163269772, 559.2226804741413, 577.8815342854705, 600.9729562169625, 602.9668368239701, 3755.417910223865, 3854.903627409281, 3906.8632597858937, 3922.941155882664, 3923.7841918694744, 90183.19633607291, 91451.54274228719, 91522.08477915269, 91774.0, 92320.0, 67477.0, 69119.30880691129, 71224.0, 77782.0, 79755.60122199469, 53157.734211328694, 58898.0, 62403.6879815598, 65851.01223481652, 67128.66435667888, 7949.364050875801, 8234.423590348619, 8268.932766808299, 8301.6679332826, 8374.162583741578, 45090.425717984435, 45310.546894530635, 45552.08895821999, 45867.31199032084, 46255.0, 63258.0, 66757.0, 67118.0, 67182.0, 67561.2304584979, 10725.195610329412, 11094.223404361617, 11122.388268644978, 11140.220184587326, 11319.547218111184, 11083.559137312097, 11171.0, 11895.464704088165, 12050.156489045683, 12532.498700051896, 11153.832692509457, 11400.144989126014, 11740.354280514654, 11773.705657358634, 11888.762224755283, 11152.498137583665, 11686.532538698357, 11837.289762614271, 11922.4038798058, 12114.833013244066, 11224.326540407275, 11299.661010169708, 11351.14866385008, 11671.299722016705, 11779.35213563228, 9723.0, 9842.704718858446, 9859.654912078044, 9913.107820296207, 10290.588376464857, 7260.564366138048, 7864.4888082274465, 8724.825503489768, 8876.733697989072, 9072.546372681472], "value": 6805.860893964107, "unit": "score"}], "name": "dromaeo_css", "value": 7174.100418320027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 111.0, 112.0, 114.0, 117.0, 164.0, 167.0, 113.0, 112.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 140.0, 168.0, 117.0, 138.0, 143.0, 115.0, 175.0, 121.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 184.0, 184.0, 183.0, 187.0, 183.0, 184.0, 183.0, 187.0, 181.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 86.0, 92.0, 57.0, 58.0, 57.0, 79.0, 85.0, 55.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 135.0, 77.0, 78.0, 78.0, 127.0, 80.0, 78.0, 128.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 83.0, 86.0, 84.0, 86.0, 84.0, 86.0, 87.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 100.0, 135.0, 93.0, 99.0, 92.0, 93.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 99.0, 119.0, 139.0, 138.0, 104.0, 84.0, 84.0, 85.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 61.0, 79.0, 86.0, 85.0, 87.0, 78.0, 60.0, 61.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 74.0, 75.0, 71.0, 66.0, 66.0, 66.0, 67.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 82.0, 81.0, 80.0, 81.0, 80.0, 83.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 136.0, 140.0, 138.0, 133.0, 138.0, 134.0, 177.0, 146.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 171.0, 171.0, 170.0, 170.0, 168.0, 172.0, 173.0, 167.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 67.0, 69.0, 67.0, 70.0, 68.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1510.5, "alertThreshold": 2.0}]} 05:28:23 INFO - Return code: 0 05:28:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:23 ERROR - # TBPL SUCCESS # 05:28:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:23 INFO - 2016-04-25 05:28:23.669 screenresolution[1676:10045] starting screenresolution argv=screenresolution get 05:28:23 INFO - 2016-04-25 05:28:23.671 screenresolution[1676:10045] Display 0: 1600x1200x32@60 05:28:23 INFO - 2016-04-25 05:28:23.677 screenresolution[1677:10048] starting screenresolution argv=screenresolution list 05:28:23 INFO - Available Modes on Display 0 05:28:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:23 INFO - Intel Iris: 05:28:23 INFO - Chipset Model: Intel Iris 05:28:23 INFO - Type: GPU 05:28:23 INFO - Bus: Built-In 05:28:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:23 INFO - Vendor: Intel (0x8086) 05:28:23 INFO - Device ID: 0x0a2e 05:28:23 INFO - Revision ID: 0x0009 05:28:23 INFO - Displays: 05:28:23 INFO - Display: 05:28:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:23 INFO - Display Serial Number: 1600x1200 60 05:28:23 INFO - Main Display: Yes 05:28:23 INFO - Mirror: Off 05:28:23 INFO - Online: Yes 05:28:23 INFO - Rotation: Supported 05:28:23 INFO - Return code: 0 05:28:23 INFO - Running post-action listener: _resource_record_post_action 05:28:23 INFO - Running post-run listener: _resource_record_post_run 05:28:24 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 36848128; Write bytes: 694278656; Read time: 380; Write time: 2011 05:28:24 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 376996352; Write bytes: 367532032; Read time: 27621; Write time: 674 05:28:24 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30591488; Write bytes: 296215040; Read time: 298; Write time: 1280 05:28:24 INFO - Running post-run listener: _upload_blobber_files 05:28:24 INFO - Blob upload gear active. 05:28:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:24 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 05:28:24 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'] 05:28:24 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 05:28:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:26 INFO - (blobuploader) - INFO - Done attempting. 05:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:27 INFO - (blobuploader) - INFO - Done attempting. 05:28:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:27 INFO - Return code: 0 05:28:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcd7b174116ef2bde087c5787fcc178b155fa5df8834dbf901e27c3d487a13cc4188e265d23b20e8e2d7d2a4aabef1476b32ecdcface063f83c46c2fa413b258", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17f4b9b120d2970f64aea1bf6698fb1eef330da76c691bf3fca5ea5562ccfeaf921501b67e4ee24441220080682623cbee27e507bc128c5b880bae31c294352"} 05:28:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:27 INFO - Contents: 05:28:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcd7b174116ef2bde087c5787fcc178b155fa5df8834dbf901e27c3d487a13cc4188e265d23b20e8e2d7d2a4aabef1476b32ecdcface063f83c46c2fa413b258", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17f4b9b120d2970f64aea1bf6698fb1eef330da76c691bf3fca5ea5562ccfeaf921501b67e4ee24441220080682623cbee27e507bc128c5b880bae31c294352"} 05:28:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:27 INFO - Copying logs to upload dir... 05:28:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.019664 ========= master_lag: 2.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-04-25 05:28:29.903228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:29.906576) ========= 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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/dcd7b174116ef2bde087c5787fcc178b155fa5df8834dbf901e27c3d487a13cc4188e265d23b20e8e2d7d2a4aabef1476b32ecdcface063f83c46c2fa413b258", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17f4b9b120d2970f64aea1bf6698fb1eef330da76c691bf3fca5ea5562ccfeaf921501b67e4ee24441220080682623cbee27e507bc128c5b880bae31c294352"} build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010995 build_url: 'https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcd7b174116ef2bde087c5787fcc178b155fa5df8834dbf901e27c3d487a13cc4188e265d23b20e8e2d7d2a4aabef1476b32ecdcface063f83c46c2fa413b258", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c17f4b9b120d2970f64aea1bf6698fb1eef330da76c691bf3fca5ea5562ccfeaf921501b67e4ee24441220080682623cbee27e507bc128c5b880bae31c294352"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:30.234608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:28:30.234897) ========= 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.ITid9dXdrZ/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.xx8sbd8HbI/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005043 ========= master_lag: 1.92 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:28:32.157277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:32.157577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:32.280887) ========= ========= Total master_lag: 4.55 =========