builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0109 starttime: 1461242703.37 results: success (0) buildid: 20160421025510 builduid: 56befa3ccb104e0bb0d0de85150549f3 revision: 9ad67a907cae9644493ecbabae4529602ca3fa72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.371040) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.371776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.372099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.410971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.411299) ========= 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.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-21 05:45:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-04-21 05:45:03 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086591 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.516907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.517338) ========= 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.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.020441 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:03.567029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 05:45:03.567384) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9ad67a907cae9644493ecbabae4529602ca3fa72 --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 9ad67a907cae9644493ecbabae4529602ca3fa72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-21 05:45:03,641 truncating revision to first 12 chars 2016-04-21 05:45:03,641 Setting DEBUG logging. 2016-04-21 05:45:03,641 attempt 1/10 2016-04-21 05:45:03,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9ad67a907cae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 05:45:04,729 unpacking tar archive at: fx-team-9ad67a907cae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 05:45:04.915982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:04.916288) ========= script_repo_revision: 9ad67a907cae9644493ecbabae4529602ca3fa72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:04.916692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:04.916953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:45:04.931266) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-21 05:45:04.931649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:05 INFO - MultiFileLogger online at 20160421 05:45:05 in /builds/slave/test 05:45:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:45:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:05 INFO - {'append_to_log': False, 05:45:05 INFO - 'base_work_dir': '/builds/slave/test', 05:45:05 INFO - 'blob_upload_branch': 'Fx-Team', 05:45:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:05 INFO - 'branch': 'Fx-Team', 05:45:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:05 INFO - 'config_files': ('talos/mac_config.py',), 05:45:05 INFO - 'default_actions': ('clobber', 05:45:05 INFO - 'read-buildbot-config', 05:45:05 INFO - 'download-and-extract', 05:45:05 INFO - 'populate-webroot', 05:45:05 INFO - 'create-virtualenv', 05:45:05 INFO - 'install', 05:45:05 INFO - 'run-tests'), 05:45:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:05 INFO - 'download_minidump_stackwalk': True, 05:45:05 INFO - 'download_symbols': 'ondemand', 05:45:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:05 INFO - 'installer_path': 'installer.exe', 05:45:05 INFO - 'log_level': 'info', 05:45:05 INFO - 'log_name': 'talos', 05:45:05 INFO - 'log_to_console': True, 05:45:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:05 INFO - 'opt_config_files': (), 05:45:05 INFO - 'pip_index': False, 05:45:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:05 INFO - 'cmd': ('bash', 05:45:05 INFO - '-c', 05:45:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:05 INFO - 'enabled': True, 05:45:05 INFO - 'halt_on_failure': False, 05:45:05 INFO - 'name': 'check_screen_resolution'},), 05:45:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:05 INFO - 'cmd': ('bash', 05:45:05 INFO - '-c', 05:45:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:05 INFO - 'enabled': True, 05:45:05 INFO - 'halt_on_failure': False, 05:45:05 INFO - 'name': 'check_screen_resolution'},), 05:45:05 INFO - 'run_cmd_checks_enabled': True, 05:45:05 INFO - 'sps_profile': False, 05:45:05 INFO - 'sps_profile_interval': 0, 05:45:05 INFO - 'suite': 'dromaeojs-e10s', 05:45:05 INFO - 'system_bits': '32', 05:45:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:05 INFO - 'title': 't-yosemite-r7-0109', 05:45:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:05 INFO - 'use_talos_json': True, 05:45:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:05 INFO - 'work_dir': 'build'} 05:45:05 INFO - ##### 05:45:05 INFO - ##### Running clobber step. 05:45:05 INFO - ##### 05:45:05 INFO - Running pre-action listener: _resource_record_pre_action 05:45:05 INFO - Running main action method: clobber 05:45:05 INFO - rmtree: /builds/slave/test/build 05:45:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:06 INFO - Running post-action listener: _resource_record_post_action 05:45:06 INFO - ##### 05:45:06 INFO - ##### Running read-buildbot-config step. 05:45:06 INFO - ##### 05:45:06 INFO - Running pre-action listener: _resource_record_pre_action 05:45:06 INFO - Running main action method: read_buildbot_config 05:45:06 INFO - Using buildbot properties: 05:45:06 INFO - { 05:45:06 INFO - "project": "", 05:45:06 INFO - "product": "firefox", 05:45:06 INFO - "script_repo_revision": "production", 05:45:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:45:06 INFO - "repository": "", 05:45:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:45:06 INFO - "buildid": "20160421025510", 05:45:06 INFO - "pgo_build": "False", 05:45:06 INFO - "basedir": "/builds/slave/test", 05:45:06 INFO - "buildnumber": 613, 05:45:06 INFO - "slavename": "t-yosemite-r7-0109", 05:45:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:45:06 INFO - "platform": "yosemite_r7", 05:45:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:45:06 INFO - "branch": "fx-team", 05:45:06 INFO - "repo_path": "integration/fx-team", 05:45:06 INFO - "revision": "9ad67a907cae9644493ecbabae4529602ca3fa72", 05:45:06 INFO - "stage_platform": "macosx64", 05:45:06 INFO - "builduid": "56befa3ccb104e0bb0d0de85150549f3", 05:45:06 INFO - "slavebuilddir": "test" 05:45:06 INFO - } 05:45:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:45:06 INFO - Running post-action listener: _resource_record_post_action 05:45:06 INFO - ##### 05:45:06 INFO - ##### Running download-and-extract step. 05:45:06 INFO - ##### 05:45:06 INFO - Running pre-action listener: _resource_record_pre_action 05:45:06 INFO - Running main action method: download_and_extract 05:45:06 INFO - mkdir: /builds/slave/test/build/tests 05:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:06 INFO - https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:45:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:45:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:45:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:09 INFO - Downloaded 1199 bytes. 05:45:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:45:09 INFO - Using the following test package requirements: 05:45:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:45:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:45:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:45:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'jsshell-mac.zip'], 05:45:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:45:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:45:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:45:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:45:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:45:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:45:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:45:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:45:09 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:45:09 INFO - https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:45:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:45:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:45:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:10 INFO - Downloaded 18099993 bytes. 05:45:10 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:45:10 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:45:13 INFO - Return code: 0 05:45:13 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:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:13 INFO - https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:15 INFO - Downloaded 18099993 bytes. 05:45:15 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:45:15 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:45:19 INFO - Return code: 0 05:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:19 INFO - https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:45:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:45:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:45:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:19 INFO - Downloaded 10845952 bytes. 05:45:19 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:45:19 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:45:20 INFO - Return code: 0 05:45:20 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:45:20 INFO - https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/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:45:23 INFO - Downloaded 110037234 bytes. 05:45:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:45:23 INFO - mkdir: /builds/slave/test/properties 05:45:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:23 INFO - Contents: 05:45:23 INFO - build_url:https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - Running post-action listener: set_extra_try_arguments 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running populate-webroot step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: populate_webroot 05:45:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:25 INFO - '--tppagecycles', 05:45:25 INFO - '7'], 05:45:25 INFO - 'tests': ['tsvgm']}}, 05:45:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['damp', 'tps']}, 05:45:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'tests': ['damp', 'tps']}, 05:45:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['dromaeo_dom']}, 05:45:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['a11yr', 05:45:25 INFO - 'ts_paint', 05:45:25 INFO - 'tpaint', 05:45:25 INFO - 'sessionrestore', 05:45:25 INFO - 'sessionrestore_no_auto_restore', 05:45:25 INFO - 'tabpaint']}, 05:45:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['tsvgx', 05:45:25 INFO - 'tsvgr_opacity', 05:45:25 INFO - 'tart', 05:45:25 INFO - 'tscrollx', 05:45:25 INFO - 'cart']}, 05:45:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:25 INFO - 'tsvgr_opacity', 05:45:25 INFO - 'tart', 05:45:25 INFO - 'tscrollx', 05:45:25 INFO - 'cart']}, 05:45:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'talos_options': ['--disable-e10s'], 05:45:25 INFO - 'tests': ['tp5o']}, 05:45:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'tests': ['tp5o']}, 05:45:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'talos_options': ['--disable-e10s', 05:45:25 INFO - '--xperf_path', 05:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:25 INFO - 'tests': ['tp5n']}, 05:45:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:25 INFO - 'talos_options': ['--xperf_path', 05:45:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:25 INFO - 'tests': ['tp5n']}}, 05:45:25 INFO - 'talos.zip': {'path': '', 05:45:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running create-virtualenv step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: create_virtualenv 05:45:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:25 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:45:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:25 INFO - Using real prefix '/tools/python27' 05:45:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:29 INFO - Installing pip.................done. 05:45:29 INFO - Return code: 0 05:45:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:29 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:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:29 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:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:29 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:29 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:45:29 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:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:29 INFO - 'HOME': '/Users/cltbld', 05:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:29 INFO - 'LOGNAME': 'cltbld', 05:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:29 INFO - 'MOZ_NO_REMOTE': '1', 05:45:29 INFO - 'NO_EM_RESTART': '1', 05:45:29 INFO - 'PAGER': '/bin/cat', 05:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:29 INFO - 'PWD': '/builds/slave/test', 05:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:29 INFO - 'SHELL': '/bin/bash', 05:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:29 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:29 INFO - 'USER': 'cltbld', 05:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:29 INFO - 'XPC_FLAGS': '0x0', 05:45:29 INFO - 'XPC_SERVICE_NAME': '0', 05:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:29 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:45:29 INFO - Cleaning up... 05:45:29 INFO - Return code: 0 05:45:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:45:29 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:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:29 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:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:29 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:29 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:45:29 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:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:29 INFO - 'HOME': '/Users/cltbld', 05:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:29 INFO - 'LOGNAME': 'cltbld', 05:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:29 INFO - 'MOZ_NO_REMOTE': '1', 05:45:29 INFO - 'NO_EM_RESTART': '1', 05:45:29 INFO - 'PAGER': '/bin/cat', 05:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:29 INFO - 'PWD': '/builds/slave/test', 05:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:29 INFO - 'SHELL': '/bin/bash', 05:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:29 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:29 INFO - 'USER': 'cltbld', 05:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:29 INFO - 'XPC_FLAGS': '0x0', 05:45:29 INFO - 'XPC_SERVICE_NAME': '0', 05:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:29 INFO - Downloading/unpacking psutil>=0.7.1 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:32 INFO - Installing collected packages: psutil 05:45:32 INFO - Running setup.py install for psutil 05:45:32 INFO - building 'psutil._psutil_osx' extension 05:45:32 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:45:33 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:45:33 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:45:33 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:45:33 INFO - building 'psutil._psutil_posix' extension 05:45:33 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:45:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:33 INFO - ^ 05:45:33 INFO - 1 warning generated. 05:45:33 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:45:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:33 INFO - Successfully installed psutil 05:45:33 INFO - Cleaning up... 05:45:33 INFO - Return code: 0 05:45:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:45: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:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:33 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:33 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:45:33 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:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:33 INFO - 'HOME': '/Users/cltbld', 05:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:33 INFO - 'LOGNAME': 'cltbld', 05:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:33 INFO - 'MOZ_NO_REMOTE': '1', 05:45:33 INFO - 'NO_EM_RESTART': '1', 05:45:33 INFO - 'PAGER': '/bin/cat', 05:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:33 INFO - 'PWD': '/builds/slave/test', 05:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:33 INFO - 'SHELL': '/bin/bash', 05:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:33 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:33 INFO - 'USER': 'cltbld', 05:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:33 INFO - 'XPC_FLAGS': '0x0', 05:45:33 INFO - 'XPC_SERVICE_NAME': '0', 05:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:33 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:45:33 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:45:33 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:45:33 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:45:33 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:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:36 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:45:36 INFO - Installing collected packages: mozsystemmonitor 05:45:36 INFO - Running setup.py install for mozsystemmonitor 05:45:36 INFO - Successfully installed mozsystemmonitor 05:45:36 INFO - Cleaning up... 05:45:36 INFO - Return code: 0 05:45:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:36 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:36 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:45:36 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:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:36 INFO - 'HOME': '/Users/cltbld', 05:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:36 INFO - 'LOGNAME': 'cltbld', 05:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:36 INFO - 'MOZ_NO_REMOTE': '1', 05:45:36 INFO - 'NO_EM_RESTART': '1', 05:45:36 INFO - 'PAGER': '/bin/cat', 05:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:36 INFO - 'PWD': '/builds/slave/test', 05:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:36 INFO - 'SHELL': '/bin/bash', 05:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:36 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:36 INFO - 'USER': 'cltbld', 05:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:36 INFO - 'XPC_FLAGS': '0x0', 05:45:36 INFO - 'XPC_SERVICE_NAME': '0', 05:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:36 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:39 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:39 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:45:39 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:45:39 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:45:39 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:45:39 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:45:39 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:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:40 INFO - Downloading docopt-0.6.1.tar.gz 05:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:40 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:40 INFO - Running setup.py install for blobuploader 05:45:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:40 INFO - Running setup.py install for requests 05:45:41 INFO - Running setup.py install for docopt 05:45:41 INFO - Successfully installed blobuploader requests docopt 05:45:41 INFO - Cleaning up... 05:45:41 INFO - Return code: 0 05:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:41 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:41 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:45:41 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:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:41 INFO - 'HOME': '/Users/cltbld', 05:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:41 INFO - 'LOGNAME': 'cltbld', 05:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:41 INFO - 'MOZ_NO_REMOTE': '1', 05:45:41 INFO - 'NO_EM_RESTART': '1', 05:45:41 INFO - 'PAGER': '/bin/cat', 05:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:41 INFO - 'PWD': '/builds/slave/test', 05:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:41 INFO - 'SHELL': '/bin/bash', 05:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:41 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:41 INFO - 'USER': 'cltbld', 05:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:41 INFO - 'XPC_FLAGS': '0x0', 05:45:41 INFO - 'XPC_SERVICE_NAME': '0', 05:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:41 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-mwR_Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:41 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-5448iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:41 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-F8IxYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vG0589-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rjTRSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-D3S3sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-taLA00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vbl4C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-TBBUYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Fbw0qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rMM3R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-pV3VQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:42 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-fp_lpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Pwa2yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-O7yTzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xy3QlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:43 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wO1AXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:43 INFO - Running setup.py install for manifestparser 05:45:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Running setup.py install for mozcrash 05:45:43 INFO - Running setup.py install for mozdebug 05:45:43 INFO - Running setup.py install for mozdevice 05:45:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for mozfile 05:45:44 INFO - Running setup.py install for mozhttpd 05:45:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for mozinfo 05:45:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for mozInstall 05:45:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for mozleak 05:45:44 INFO - Running setup.py install for mozlog 05:45:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for moznetwork 05:45:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Running setup.py install for mozprocess 05:45:45 INFO - Running setup.py install for mozprofile 05:45:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Running setup.py install for mozrunner 05:45:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:45 INFO - Running setup.py install for mozscreenshot 05:45:45 INFO - Running setup.py install for moztest 05:45:45 INFO - Running setup.py install for mozversion 05:45:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:46 INFO - Cleaning up... 05:45:46 INFO - Return code: 0 05:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45: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:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:46 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:46 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:45:46 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:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:46 INFO - 'HOME': '/Users/cltbld', 05:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:46 INFO - 'LOGNAME': 'cltbld', 05:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:46 INFO - 'MOZ_NO_REMOTE': '1', 05:45:46 INFO - 'NO_EM_RESTART': '1', 05:45:46 INFO - 'PAGER': '/bin/cat', 05:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:46 INFO - 'PWD': '/builds/slave/test', 05:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:46 INFO - 'SHELL': '/bin/bash', 05:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:46 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:46 INFO - 'USER': 'cltbld', 05:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:46 INFO - 'XPC_FLAGS': '0x0', 05:45:46 INFO - 'XPC_SERVICE_NAME': '0', 05:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-4LzirO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-G67g4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-qOjEp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-cyoHo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wKsuPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-GcMF96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:46 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:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:46 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-mjY4B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-GkGIes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-XwVLZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-2IwKjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-UUeyZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-jExFZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-7wRROw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vuncC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-J3aJz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:47 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:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-i5VAjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:48 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:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-pAMaH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:48 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:45:48 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:45:48 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:45:48 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:45:48 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:45:48 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:45:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:50 INFO - Downloading blessings-1.6.tar.gz 05:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:50 INFO - Installing collected packages: blessings 05:45:50 INFO - Running setup.py install for blessings 05:45:50 INFO - Successfully installed blessings 05:45:50 INFO - Cleaning up... 05:45:50 INFO - Return code: 0 05:45:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:51 INFO - Reading from file tmpfile_stdout 05:45:51 INFO - Current package versions: 05:45:51 INFO - blessings == 1.6 05:45:51 INFO - blobuploader == 1.2.4 05:45:51 INFO - docopt == 0.6.1 05:45:51 INFO - manifestparser == 1.1 05:45:51 INFO - mozInstall == 1.12 05:45:51 INFO - mozcrash == 0.17 05:45:51 INFO - mozdebug == 0.1 05:45:51 INFO - mozdevice == 0.48 05:45:51 INFO - mozfile == 1.2 05:45:51 INFO - mozhttpd == 0.7 05:45:51 INFO - mozinfo == 0.9 05:45:51 INFO - mozleak == 0.1 05:45:51 INFO - mozlog == 3.1 05:45:51 INFO - moznetwork == 0.27 05:45:51 INFO - mozprocess == 0.22 05:45:51 INFO - mozprofile == 0.28 05:45:51 INFO - mozrunner == 6.11 05:45:51 INFO - mozscreenshot == 0.1 05:45:51 INFO - mozsystemmonitor == 0.0 05:45:51 INFO - moztest == 0.7 05:45:51 INFO - mozversion == 1.4 05:45:51 INFO - psutil == 3.1.1 05:45:51 INFO - requests == 1.2.3 05:45:51 INFO - wsgiref == 0.1.2 05:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:51 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:45:51 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:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:51 INFO - 'HOME': '/Users/cltbld', 05:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:51 INFO - 'LOGNAME': 'cltbld', 05:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:51 INFO - 'MOZ_NO_REMOTE': '1', 05:45:51 INFO - 'NO_EM_RESTART': '1', 05:45:51 INFO - 'PAGER': '/bin/cat', 05:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:51 INFO - 'PWD': '/builds/slave/test', 05:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:51 INFO - 'SHELL': '/bin/bash', 05:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:51 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:51 INFO - 'USER': 'cltbld', 05:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:51 INFO - 'XPC_FLAGS': '0x0', 05:45:51 INFO - 'XPC_SERVICE_NAME': '0', 05:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 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:45:51 INFO - Cleaning up... 05:45:51 INFO - Return code: 0 05:45:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:51 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:51 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:45:51 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:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:51 INFO - 'HOME': '/Users/cltbld', 05:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:51 INFO - 'LOGNAME': 'cltbld', 05:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:51 INFO - 'MOZ_NO_REMOTE': '1', 05:45:51 INFO - 'NO_EM_RESTART': '1', 05:45:51 INFO - 'PAGER': '/bin/cat', 05:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:51 INFO - 'PWD': '/builds/slave/test', 05:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:51 INFO - 'SHELL': '/bin/bash', 05:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:51 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:51 INFO - 'USER': 'cltbld', 05:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:51 INFO - 'XPC_FLAGS': '0x0', 05:45:51 INFO - 'XPC_SERVICE_NAME': '0', 05:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:52 INFO - Downloading/unpacking jsonschema 05:45: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:45: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:45: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:45: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:45: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:45: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:45:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:54 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:55 INFO - warning: no files found matching '*.txt' 05:45:55 INFO - no previously-included directories found matching 'build' 05:45:55 INFO - no previously-included directories found matching 'dist' 05:45:55 INFO - no previously-included directories found matching '.git*' 05:45:55 INFO - Installing collected packages: jsonschema, functools32 05:45:55 INFO - Running setup.py install for functools32 05:45:55 INFO - warning: no files found matching '*.txt' 05:45:55 INFO - no previously-included directories found matching 'build' 05:45:55 INFO - no previously-included directories found matching 'dist' 05:45:55 INFO - no previously-included directories found matching '.git*' 05:45:55 INFO - Successfully installed jsonschema functools32 05:45:55 INFO - Cleaning up... 05:45:55 INFO - Return code: 0 05:45:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:56 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:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:56 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 0x108390a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd713c86780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, '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.kcViQzL7zM/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.7ItrjUlvzj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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:45:56 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:45:56 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:45:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:45:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:56 INFO - 'HOME': '/Users/cltbld', 05:45:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:56 INFO - 'LOGNAME': 'cltbld', 05:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:56 INFO - 'MOZ_NO_REMOTE': '1', 05:45:56 INFO - 'NO_EM_RESTART': '1', 05:45:56 INFO - 'PAGER': '/bin/cat', 05:45:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:56 INFO - 'PWD': '/builds/slave/test', 05:45:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:56 INFO - 'SHELL': '/bin/bash', 05:45:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:45:56 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:45:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:56 INFO - 'USER': 'cltbld', 05:45:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:56 INFO - 'XPC_FLAGS': '0x0', 05:45:56 INFO - 'XPC_SERVICE_NAME': '0', 05:45:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:56 INFO - Downloading/unpacking flake8 05:45:56 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:45:56 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:45:56 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:45:56 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:45:56 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:45:56 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:45:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 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:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:00 INFO - no previously-included directories found matching 'docs/_build' 05:46:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:00 INFO - Running setup.py install for pep8 05:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:00 INFO - no previously-included directories found matching 'docs/_build' 05:46:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:46:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:00 INFO - Cleaning up... 05:46:00 INFO - Return code: 0 05:46:00 INFO - Running post-action listener: _resource_record_post_action 05:46:00 INFO - Running post-action listener: _start_resource_monitoring 05:46:00 INFO - Starting resource monitoring. 05:46:00 INFO - ##### 05:46:00 INFO - ##### Running install step. 05:46:00 INFO - ##### 05:46:00 INFO - Running pre-action listener: _resource_record_pre_action 05:46:00 INFO - Running main action method: install 05:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Output received: 05:46:00 INFO - Usage: mozinstall [options] installer 05:46:00 INFO - Options: 05:46:00 INFO - -h, --help show this help message and exit 05:46:00 INFO - -d DEST, --destination=DEST 05:46:00 INFO - Directory to install application into. [default: 05:46:00 INFO - "/builds/slave/test"] 05:46:00 INFO - --app=APP Application being installed. [default: firefox] 05:46:00 INFO - mkdir: /builds/slave/test/build/application 05:46:00 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:46:00 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:46:34 INFO - Reading from file tmpfile_stdout 05:46:34 INFO - Output received: 05:46:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:46:34 INFO - Running post-action listener: _resource_record_post_action 05:46:34 INFO - ##### 05:46:34 INFO - ##### Running run-tests step. 05:46:34 INFO - ##### 05:46:34 INFO - Running pre-action listener: _resource_record_pre_action 05:46:34 INFO - Running main action method: run_tests 05:46:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:34 INFO - 2016-04-21 05:46:34.146 screenresolution[2507:41495] starting screenresolution argv=screenresolution get 05:46:34 INFO - 2016-04-21 05:46:34.149 screenresolution[2507:41495] Display 0: 1600x1200x32@60 05:46:34 INFO - 2016-04-21 05:46:34.155 screenresolution[2508:41497] starting screenresolution argv=screenresolution list 05:46:34 INFO - Available Modes on Display 0 05:46:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:34 INFO - Intel Iris: 05:46:34 INFO - Chipset Model: Intel Iris 05:46:34 INFO - Type: GPU 05:46:34 INFO - Bus: Built-In 05:46:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:34 INFO - Vendor: Intel (0x8086) 05:46:34 INFO - Device ID: 0x0a2e 05:46:34 INFO - Revision ID: 0x0009 05:46:34 INFO - Displays: 05:46:34 INFO - Display: 05:46:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:34 INFO - Display Serial Number: 1600x1200 60 05:46:34 INFO - Main Display: Yes 05:46:34 INFO - Mirror: Off 05:46:34 INFO - Online: Yes 05:46:34 INFO - Rotation: Supported 05:46:34 INFO - Return code: 0 05:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:34 INFO - Python 2.7.3 05:46:34 INFO - Return code: 0 05:46:34 INFO - grabbing minidump binary from tooltool 05:46: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:46:34 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 0x10822fe00>, '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 0x108098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10822ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:34 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:46:34 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:46:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:34 INFO - Return code: 0 05:46:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:46:35 INFO - Return code: 0 05:46:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:46:35 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kcViQzL7zM/Render', 05:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:35 INFO - 'HOME': '/Users/cltbld', 05:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:35 INFO - 'LOGNAME': 'cltbld', 05:46:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:35 INFO - 'MOZ_NO_REMOTE': '1', 05:46:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:35 INFO - 'NO_EM_RESTART': '1', 05:46:35 INFO - 'PAGER': '/bin/cat', 05:46:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:35 INFO - 'PWD': '/builds/slave/test', 05:46:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:35 INFO - 'SHELL': '/bin/bash', 05:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ItrjUlvzj/Listeners', 05:46:35 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 05:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:35 INFO - 'USER': 'cltbld', 05:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:35 INFO - 'XPC_FLAGS': '0x0', 05:46:35 INFO - 'XPC_SERVICE_NAME': '0', 05:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:46:35 INFO - mozversion application_buildid: 20160421025510 05:46:35 INFO - mozversion application_changeset: 9ad67a907cae9644493ecbabae4529602ca3fa72 05:46:35 INFO - mozversion application_display_name: Nightly 05:46:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:35 INFO - mozversion application_name: Firefox 05:46:35 INFO - mozversion application_remotingname: firefox 05:46:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:46:35 INFO - mozversion application_vendor: Mozilla 05:46:35 INFO - mozversion application_version: 48.0a1 05:46:35 INFO - mozversion platform_buildid: 20160421025510 05:46:35 INFO - mozversion platform_changeset: 9ad67a907cae9644493ecbabae4529602ca3fa72 05:46:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:46:35 INFO - mozversion platform_version: 48.0a1 05:46:35 INFO - using testdate: 1461242795 05:46:35 INFO - actual date: 1461242795 05:46:35 INFO - starting webserver on 'localhost:61639' 05:46:35 INFO - SUITE-START | Running 2 tests 05:46:35 INFO - TEST-START | dromaeo_css 05:46:35 INFO - operating with platform_type : mac_ 05:46:35 INFO - Initialising browser for dromaeo_css test... 05:46:35 INFO - TEST-INFO | started process 2526 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpiijLre/profile http://localhost:61639/getInfo.html) 05:46:38 INFO - PROCESS | 2526 | __metrics Screen width/height:1600/1200 05:46:38 INFO - PROCESS | 2526 | colorDepth:24 05:46:38 INFO - PROCESS | 2526 | Browser inner width/height: 1024/689 05:46:38 INFO - PROCESS | 2526 | __metrics 05:46:38 ERROR - PROCESS | 2526 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:46:39 INFO - TEST-INFO | 2526: exit 0 05:46:39 INFO - Browser initialized. 05:46:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:39 INFO - TEST-INFO | started process 2529 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpiijLre/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:51 INFO - PROCESS | 2529 | RSS: Main: 247771136 05:46:51 INFO - PROCESS | 2529 | 05:47:40 INFO - PROCESS | 2529 | 1461242860810 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:49:52 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61639/tests/dromaeo/cssquery-ext.html) 05:49:54 INFO - PROCESS | 2529 | RSS: Main: 260235264 05:49:54 INFO - PROCESS | 2529 | 05:52:56 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-ext.html (next: http://localhost:61639/tests/dromaeo/cssquery-jquery.html) 05:52:57 INFO - PROCESS | 2529 | RSS: Main: 271945728 05:52:57 INFO - PROCESS | 2529 | 05:55:58 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61639/tests/dromaeo/cssquery-mootools.html) 05:55:59 INFO - PROCESS | 2529 | RSS: Main: 274604032 05:55:59 INFO - PROCESS | 2529 | 05:59:01 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61639/tests/dromaeo/cssquery-prototype.html) 05:59:01 INFO - PROCESS | 2529 | RSS: Main: 275619840 05:59:01 INFO - PROCESS | 2529 | 06:02:04 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61639/tests/dromaeo/cssquery-yui.html) 06:02:05 INFO - PROCESS | 2529 | RSS: Main: 278466560 06:02:05 INFO - PROCESS | 2529 | 06:05:07 INFO - PROCESS | 2529 | Cycle 1(1): loaded http://localhost:61639/tests/dromaeo/cssquery-yui.html (next: http://localhost:61639/tests/dromaeo/cssquery-dojo.html) 06:05:08 INFO - PROCESS | 2529 | RSS: Main: 279658496 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | __start_tp_report 06:05:08 INFO - PROCESS | 2529 | _x_x_mozilla_page_load 06:05:08 INFO - PROCESS | 2529 | _x_x_mozilla_page_load_details 06:05:08 INFO - PROCESS | 2529 | |i|pagename|runs| 06:05:08 INFO - PROCESS | 2529 | |0;dojo.html;3194.536792165136;3481.0079127448676;3508.403571392863;3537.699295559877;3580.087077795162;4301.505326887409;5440.727963601824;5490.258815059966;5916.0830071338905;5976.671283079429;4886.511348865111;5083.745812709359;5851.444112809287;6063.939360606392;6088.604240724349;5296.232046353276;5305.32579232955;5376.7042812645195;5378.381486129106;5455.318085239345;4333.804978775946;4708.364370809931;5436.184572314165;5487.286652735139;5505.889882202354;4539.682222244444;5310.575153987672;5472.097103977839;5481.506664400204;5497.532709719679;5320.733963301819;5394.7842086316505;5399.244105825188;5429.782808687648;5464.480874316933;5267.209918512215;5304.708241046741;5334;5375;5381.7578208980685;5304.151335786294;5508.14623733322;5820.010598198316;5850.853728656775;5934.050551911717;5284.5467496438405;6132.845047373359;6274.623522588659;6287.056941458772;6290.842728931813;6329.523667239352;6369.617822930639;6375.904361434582;6381.266154392258;6382.329855365167;4986.977669577728;5961.344252132262;6090.177825993478;6093.512518998469;6108.938910610837;6454.838629034311;6471.967640161769;6472.805815825533;6478.4169424752;6506.837329066717;6236.6258024517765;6240.344763799826;6243.469305109116;6254.74981000764;6260.029695397221;6125.815438131368;6192.938070619236;6307.590006649553;6359.17330747;6377.521685873486;6129.908988904127;6246.875062498724;6258.499320054385;6262.3111457739615;6288.119663247149;6236.968815155895;6251.718672659741;6273.37266273369;6287.96856015717;6295.653739044396;4974.701517908865;5052.671576347526;5098.46466121052;5124.615653825978;5134.7946082156295;4543.704659197141;4577.1074640444795;4585.77071146448;4589.5181005994555;4595.931061034087;6043.637381757108;6055.697215139314;6073.210482637229;6074.936886044925;6079.939200607937;6186.10301506279;6250.4374606285655;6303;6352.904706429407;6363.0455431684695;5927.881442371128;5931.73307201177;6032.4570788629235;6067.211262535842;6076.635401875901;4679.344891715163;5440.863978400572;5571.220029195916;5579.218909352694;5580.804671836466;6500.577462464925;6576.5067619928695;6609.405153536205;6624.701888414937;6675.365840245266;6351.237851457855;6359.586626869239;6359.7456101755415;6362.491000720024;6405.967970160305;5536.2249285099315;6361.904571431525;6466.0947467355545;6570.047343135314;6576.967115164393;6180.81457556274;6231.875362492816;6277.403646653561;6288.779892703734;6311.779087732091;6309.337519560564;6349.904751428639;6356.555041147075;6362.77730279438;6381.776637817654;6093.086037094471;6139.416755408229;6146.555559443438;6158.261008678808;6183.072539119168;6137.754489820536;6146.9550176471;6214.937850621436;6232;6236.75052997875;6044.0933859919605;6085.421884920926;6095.9390406097145;6113.266408030887;6171.537134715004;6119.724612392364;6131.162586540493;6193.4425901669065;6244.438000579969;6245.750169993149;5056.494350564914;6162.815115546541;6169.043798211284;6172.444479996821;6173.783917563043 06:05:08 INFO - PROCESS | 2529 | |1;ext.html;510.66551408827206;559.7816851427947;587.8507517802697;591.2756872830782;639.2520750721658;31341;31739.841300793465;39253;39357.803210983904;39381.60618393815;42762.57237427625;42909.14181716372;42965;43518.12963740723;43635.563644363545;9475.24198064155;9651.951740241324;9715;9719.95140024299;9741.269404794668;7704.537727736354;9300.395474294182;9743.171830394425;9755.122039016487;9767;9598.328117031811;9692.612295508206;9707.369021013646;9743.22054235663;9756.97551757066;8428.115047920002;8714.520701361422;9409.717708468723;9720.173785228264;9773;9653.565589548418;9753.21974242059;9776.51117444132;9806.803863922752;9807.26445516582;39066.02334941621;39072.21855562901;39312.410313845314;39375;39525.20949581021;2647.695515015759;2932.472155012097;2953.9113826585235;3115.610548681415;3339.4990751387245;22365.888170559207;25716.457012579303;25745.35636609081;26413.207603771916;26766.19701408961;2652.562327216007;2733.275681944286;2766.5573508238585;2767.1006922749984;2807.9298017549727;299263;300487;300777.4961125202;302145.97854021617;493620;59997.800043998875;60147.39852601506;60622.393776062556;60801;60898.695506522185;61716.76566468735;62321.68839155775;62353.688231559456;62436.06345904815;62637.747245054845;16747.497575072768;17122.48632541001;17135.88616739908;17335.913320433316;17393.304267829146;13110.60668179937;13359;13521.256330901699;13558.915286777232;13581.796273055912;19919.502012449804;20120.29578964729;20126.59746805085;20147.798522014593;20254.493637659176;6809.319068093151;7240.565566066053;8100.93426176333;8132.1867813218205;8137.959310203411;865.7229686500385;1007.7329507680471;1056.498163372392;1073.1843798713035;1087.9718665860685;30113;30252.84873575618;30336.84831575828;30826.53760193599;30998.915037973562;1061.4109169411051;1090.7709381030072;1179.687382843547;1234.2594443333928;1257.1828311597535;15225;15518.844811551966;15725;15923.681526369408;15980.76028859568;744112;756160;764770;765012;766470;41465;57788.42211577915;58952;59547.702261489285;62595.6870215646;1439.4961763382942;1491.1500444746607;1492.701459708041;1502.81966164061;1504.285464404421;24662;29610.111696649135;30685.693143068285;31330;31341.05976820699;54369.18446223389;54502;55222.17166742422;55311;55576;587450;593001;601988;602441;603210;23862.522749544565;27324.590131147652;27346.863265683543;28001.71998279991;28281.57577636296;39000;46303.76848115738;46588.7670561645;47512.52487475081;48486.03027939492;35743;37227.255454891296;37325.81337093297;37973;37978.8101059504;35096.12259693426;37270.44094338641;37308.813635344464;37749.245015100096;38290.42564361593;34846.47730284098;38439.423408649454;38924.2215155701;39086.2182756349;39626.80186599164;27217.86391068032;28023.579646304916;32198.28056362605;33584.49623255702;33713.66286337203;20802;25205.243842684748;25230.74769252284;25504.617430738184;25534.361640959123 06:05:08 INFO - PROCESS | 2529 | |2;jquery.html;403.91921615676864;406.63606072565057;407.2100125756031;408.63631368082406;415.6118563996252;17488.82511174888;20663.690044649342;20725.963701814926;21471.67792483114;21581.67627485589;15829.60425989351;19535.21859125637;19748.50628734279;20538.794612053876;20652.586948261025;5681.801136960197;5824.621399609033;5890.322612899528;5932.792352267671;5940.3762604926505;4771.952280477203;5836.978528757471;5859.326177489601;5921.792737254197;5978.22283103196;5815.680137592431;5882.029465138247;5885.61743486672;5940.257467816523;5961.85095372617;5044.39467263927;5486.533644640211;5681.403452637496;5808.332041815203;5874.88250234995;5443.1835224716215;5583.497485226349;5675.063614503643;5785.739641716133;5790.10253410722;12715.87284127156;12901.612951611467;13047.347632618426;13083.672908177277;13417.194968301836;1958.5005823514912;1993.8105879941381;2046.5292982614083;2054.9519744930044;2146.4848436375314;8805.911940880573;9713.46575938323;9797.706068817875;9892.208623310118;9987.850182247272;1664.167916041979;1732.5322163016042;1740.2169023939277;1745.5025317784498;1754.7280171573427;114563;119054;119330.40334798358;119669;121561;11465.54137834494;11541.596044138414;11697.824532632018;11730.589429370102;11785.469653865597;13067.607971760863;14746.778798317819;14816.3332650031;14890.925545372203;15008.399664013317;7030.613316267654;7043.788686339418;8118;8448.78878028042;8532.402731808714;7214.422846172293;8370.079291277954;8432.451890627211;8608.698695545625;8609.61256743448;3736.308782875177;4440.800163992628;4512.278035514302;4577.679562430598;4580.496145424001;1911.5890083632087;1962.6271008508338;1971.3297478857257;1976.3280484635293;1997.211101614854;849.1423662101199;882.0759183307443;935.3172184305495;1004.0320970897124;1090.9945450272699;17217.794754367325;17893.10534473271;18993.81006189948;19577.902110489358;20162;994.9950250248702;996.3324572536418;1002.4236064263077;1019.6788011776267;1042.74452759073;10376.533056012497;10544.209184311207;10583.576656933636;10612.681619551426;10628.734281643021;529321;532469;533560;573289;620562;129122;138399;138419;145967;150217;1052.2897044494935;1077.590515604081;1131.4229742831214;1133.3086817041599;1135.9772804543863;17859;17909.552261193574;17922.283108675507;18042.639147217244;18246.908765456617;52748.36258187152;53632.73183634213;53890.766554006885;54194.64513387039;54400.45599543954;69244.65377673079;77165.22834771805;77879;78605.2139478598;80373;6760.850655388694;7659.731909383145;7889.75227072726;8117.391195660467;8148.5518296494265;10691.358518488916;12067.698307542381;12360.75278494443;12468.127231093737;12487.12590118683;10380.429076400871;10496.47517624131;10891.455427228766;10953.56185752561;10964.451777411257;10411.94794026025;10511;10534.315269507457;10689.625863094754;10800.40597767099;8954.238889694449;10997.065249453886;11192.38441885704;11257.437128143723;11278.661640150809;7909.9209007909185;7914.762557123296;7925.326347260317;7999.520028798058;8263.834723305621;8288.171182881664;10330.431826249629;10737.731556711145;11122.777544449227;11138.997490225594 06:05:08 INFO - PROCESS | 2529 | |3;mootools.html;1603.454825359378;1605.9839401605984;1800.3878681248373;1898.3545594497878;1990.5521257717007;7629.656665450054;8061.234182752629;8658.523781192032;8664.176903194202;8958.776030599238;8540.145985401457;8590.742277731662;8626.568671566412;8692.130786921305;8699.217070463657;2460.052879641333;2485.3662316109458;2489.65144879717;2492.439201179729;2496.1887386599337;2427.8786060696984;2465.2480993297036;2492.0405643827166;2501.17461237792;2529.4435224250637;2453.4479742057983;2456.778889899909;2492.1651246832243;2506.0727530813624;2506.724260331362;2441.914532991346;2447.400386905211;2467.864267465289;2493;2499.8375105618256;2430.2952143878256;2430.890609922558;2454.349597356684;2463.864487453189;2477.690288713911;8874.733757987271;8930.598123084477;8944.284457243404;8961.507117108556;8981.685641002534;5287.154055351125;5495.230667706524;5504.972475137639;5508.889822203533;5518.862028449281;3485.5817301923676;3514.0863375522295;3557.5908770491465;3650.7809531428197;3663.065918190871;795.5465384730705;1010.5503051142244;1035.9482025898674;1051.7580956380075;1089.0742868561738;9305.022972587849;11421;11647.126465515035;11651.883481165165;11705.122115841346;4667.416572928384;4818.613886690849;4819.855404337875;4862.294967229803;4924.409070911442;9849.901500985041;9909.058639429388;9962.203023758228;9979.201663866874;10021.549030293654;5456.863578410492;5482.698451585121;5486.1770734389365;5495;5505.449455054462;4452.109578084396;4797.712137271775;4917.286993385939;4965;4965.776540055706;3946.546147193052;4011.8395264189107;4046.2716710992304;4057.411675307123;4159.126583417456;1254.8243245945575;1259.0619988108917;1265.2724683306951;1274.7832868412393;1303.478608556566;819.3117781063935;826.1490664615455;874.5627186406797;912.8630705394244;935.4714586258742;5522.5581953443625;5632.662040277596;5907.409259074058;5913.852153696106;6129.969350153221;939.9812003759887;942.8255772682076;944.7779771753633;963.9807203856024;981.6355266180016;3823.9235215296094;3921.941170882439;3931.1351502669368;3978.1446988896946;3992.5208974923194;10356.896431035744;10500.842487362695;10625.203109766799;10701.250912436055;10711.732206694895;10733.570657173781;10738.570457181782;10743.946280268548;10773.62292319765;11029.83455248172;7908.327792137733;8165.63254653542;8269.793255168548;8317.958410208032;8376.790580235665;5606.355269144101;5740.253767010262;5819.243498345188;5853.326867410302;5883.764649413975;9917.851232231667;9972.750681233027;9974.950125249617;10068.295219334575;10102.79794404093;9348.298877584073;9582.808343832945;10061.949690251502;10087.39475631435;10132.44271565071;6851.897221541781;6950.652467376712;7337.376323012603;7521.05986751656;7575.24247575238;8289.212524810133;8305.211004954519;8398.496090234605;8402.285805706584;8416.747497575083;7280.417566594766;7322.890156647548;7463.701451941862;7536.547807131589;7545.358644515058;7126.572405655677;7128.536645118051;7172.748953786592;7239.601821899846;7282.854342913006;7010.544314619533;7024.754133605299;7071.116110486189;7098.148222213367;7113.679884405111;4569.977150114228;4636.281376386665;4673;4728.787204575871;4810.783514741915;4905.48492408292;4908.852734417973;4926.704397736147;4952.133376659142;4999.175136102503 06:05:08 INFO - PROCESS | 2529 | |4;prototype.html;320.300144184956;325.1351405262003;331.8291080093751;335.67942614802865;337.33376581252014;5380.488853558915;6093.299270583873;6242.843928901774;6277.246730392354;6355.7139928703145;5866.685322792619;6281.183446151994;6285.968570157154;6288.968555157229;6292.244930608334;3968.9404658929993;4549.226631472658;4747.8338258160975;4768.856934291968;4775.212090005145;4340.240457919851;4378.452693413324;4427;4652.604528615072;4685.976570117162;4003.5996400360023;4053.945974046754;4120.917581648365;4385.912281754363;4642.07158568286;4154.688398370119;4164.895877603054;4406.383106365111;4672;4685.8594242172785;3375.8312084395684;3657.2319812839337;3909.377608292555;3933;3939.2273476935493;5483.561315094783;6001.609895356832;6017.849553761147;6036.9396306036815;6065.848353791146;4616.44602647681;4796.544328288807;4892.168331383673;5350;5433.809816656438;6094.329623741385;6340.682965851689;6447.742090316382;6612.636305003223;6672.33106757301;4333.090051089275;4336.327869180251;4355;4359.8882285017435;4380.474343078851;6559.409653131241;7001.929980700179;7076.513932074271;7080.114985626797;7087.468439866979;4358.36803663467;4374.4094547236355;4390.165868484977;4393.1872603568445;4407.2507673695545;3970.841166353371;4465.866024019285;4479.148961697267;4495;4504.324351347324;4010.6189911958318;5214.426413094557;5299.178627312773;5364.8122315718765;5370.624056316098;6293.559450838397;6437.871242575122;6706.329367063352;6717.429018533479;6776.15298087739;1521.269790500566;1533.5476034569829;1541.5201406649517;1545.4436402894949;1545.63677535779;972.3873959405671;985.1380042462845;990.9752256193652;998.8451789972565;1006.2955930848435;6151.477124444383;6184.443400094013;6218.906716399258;6223.96888015557;6234.75060997555;6241.251049873953;6942.271061538567;6942.618156001367;6961.060256865359;7019.227884932653;5231.607629427808;6203.875922481525;6207.503399728102;6219.440250377488;6254.249490061222;3611.422172452395;3614.1868079682386;3651.94522082169;3660.194757153422;3681.815909204529;5506.311711036121;5726.77092916287;7147.249538798351;7181.4972951893915;7269.600171990592;7062.364387205176;7207.207207207203;7222.566646001257;7222.7472038479455;7250.456215783837;6606.438452731475;6786.219584747719;7296.744613938593;7331.890021649573;7358.300961408658;6921.031055652314;6938.618375989369;6967.895481567679;6992.4406047517095;6995.790126296016;6095.725692343766;6517.185351831021;6607.174103237096;6870.3473170048765;6960.095187625576;6560.868782624416;6571.57284776488;7260.818479538054;7292.854142917218;7299.226294008243;4149.813258403439;4402.053558484941;4409.22838503267;4436.82252709888;4451.910961780682;4951.009278772725;5396.631974270242;5934.732937017931;6955.426492197919;6978.336373404003;6397.744090236339;6406.583572067801;6639.269680335063;6706.128203333536;6756.121704178426;5549.833504994856;6609.372109649576;6620.6427682325975;6682.799516014527;6700.765473208415;5180.559652429586;5403.729813509231;6031.75872965094;6493.253275873146;6545.345465453416;5578.414266502121;6135.754569817157;6648.501362397937;6702.229243637044;6766.661666916733;5451.945480545302;5704.286964129484;6525.510586705921;6531.477481801539;6584.390926351477 06:05:08 INFO - PROCESS | 2529 | |5;yui.html;673.4948788408691;676.580520077552;706.9540479868805;721.3760097515651;754.7660225330148;14518.201498917555;14674.339654715537;15112.999999999973;15116.999999999985;15271.236438178088;14234.217118058503;14234.715305693906;14245.572632821006;14421.134731916092;14481.42074317026;733.5122143774383;897.5915958239018;906.4697152165991;935.854942483916;938.9906100939006;918.0681608167715;926.8378033844084;939.2157548447055;940.1068984464752;942.0673533202115;829.7386323308139;937.3485427627801;981.6711401680445;986.3440811860105;986.4968865878418;728.3153835394738;940.6096469965024;964.5868802204768;978.5694294510392;978.5938835383344;691.1740470138187;693.5110746923407;693.923668396481;695.8121307247065;735.9411247100219;15189.240537973168;15221.61945951349;15295;15342.693146137015;15368.769468457982;12746.235225886383;12854;12861.87138128616;13018.86981130186;13333.933330333286;11047.944760276147;11191.216614836965;11200;11351.489182986785;11574.305541667527;4095.406166105898;4156.376543518466;4258.765767882765;4296.74219546825;4307.289297265978;60179.699101504215;85173;87486.5625671874;88140.5592972031;88458;9629.711108666752;9814.65648702292;9924.206063514901;10148.797024059477;10282.691519254435;22692.773072269065;22860;22860.65709014366;22877.31368058961;22893.427664308194;7421.962890185622;7515.887261691079;7575.848483030309;7583.090029196532;7622.428317876182;4079.1841631673783;4100.610442008005;4120.072983578671;4123.835046598102;4124.4019617155345;3636.818159092035;3652.3790955537625;3679.632036796299;3713.0717320669833;3752.1182522107283;658.8319978405476;668.6021817018866;669.0332469581506;671.0906721392442;675.4022689919457;511.4042140905803;562.3364429972671;569.7493103034651;578.5863107877803;586.5981802465325;7576.28025337592;7642.700740874065;7763.844723105506;7793.298603125746;8118.092188672946;496.9155243608523;529.6599701572175;567.4637467593168;569.5870493891978;579.3655946738314;3708.647678470541;3789.147441825567;3809.7142714296538;3813.523309586302;3818.4845045919;92282.53858730664;92410;94140;94201;95368.52315738377;81005;81224.59387703023;81821.18178818254;81885;81969;74627.88058179132;75065.36889931794;75503;75634.86547701788;76273.23726762773;6289.962156244169;6370.29926708071;7393.260673932564;7525.24747525265;7583.355414789805;43103;44449.11101778011;44612.88467788331;44908.550914490435;45009.42467013639;45305.86735331643;57225.71387143204;57386.42613573811;61131;61172.69413652903;11070;11242.437878106226;11367.261128026652;11475.311481311148;12225.266484010632;11770.882291176978;11890.643280701594;11986.880131198577;12043.578474753342;12061.879381206076;11236.719082023015;11267.436628168394;11276.041536469493;11392.43037848121;11574.974379483388;9833.754156145867;11399.943000284946;11677.357745324089;11892.881071189177;12048.638540843789;11204.047655949336;11271.436428178722;11337.716557086138;11593.6521904343;11793.410329483662;7395.667194976347;8438.071812100787;8869.512176830336;9348.626054957998;9497.952510237405;8400.579971001303;9937.801243975224;9948.55231514598;10098.747531311776;10136.695899123039 06:05:08 INFO - PROCESS | 2529 | __end_tp_report 06:05:08 INFO - PROCESS | 2529 | __start_cc_report 06:05:08 INFO - PROCESS | 2529 | _x_x_mozilla_cycle_collect,398 06:05:08 INFO - PROCESS | 2529 | __end_cc_report 06:05:08 INFO - PROCESS | 2529 | __startTimestamp1461243908039__endTimestamp 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | ------- Summary: start ------- 06:05:08 INFO - PROCESS | 2529 | Number of tests: 6 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#0] dojo.html Cycles:165 Average:5825.11 Median:6113.27 stddev:685.86 (11.2%) stddev-sans-first:656.19 06:05:08 INFO - PROCESS | 2529 | Values: 3194.5 3481.0 3508.4 3537.7 3580.1 4301.5 5440.7 5490.3 5916.1 5976.7 4886.5 5083.7 5851.4 6063.9 6088.6 5296.2 5305.3 5376.7 5378.4 5455.3 4333.8 4708.4 5436.2 5487.3 5505.9 4539.7 5310.6 5472.1 5481.5 5497.5 5320.7 5394.8 5399.2 5429.8 5464.5 5267.2 5304.7 5334.0 5375.0 5381.8 5304.2 5508.1 5820.0 5850.9 5934.1 5284.5 6132.8 6274.6 6287.1 6290.8 6329.5 6369.6 6375.9 6381.3 6382.3 4987.0 5961.3 6090.2 6093.5 6108.9 6454.8 6472.0 6472.8 6478.4 6506.8 6236.6 6240.3 6243.5 6254.7 6260.0 6125.8 6192.9 6307.6 6359.2 6377.5 6129.9 6246.9 6258.5 6262.3 6288.1 6237.0 6251.7 6273.4 6288.0 6295.7 4974.7 5052.7 5098.5 5124.6 5134.8 4543.7 4577.1 4585.8 4589.5 4595.9 6043.6 6055.7 6073.2 6074.9 6079.9 6186.1 6250.4 6303.0 6352.9 6363.0 5927.9 5931.7 6032.5 6067.2 6076.6 4679.3 5440.9 5571.2 5579.2 5580.8 6500.6 6576.5 6609.4 6624.7 6675.4 6351.2 6359.6 6359.7 6362.5 6406.0 5536.2 6361.9 6466.1 6570.0 6577.0 6180.8 6231.9 6277.4 6288.8 6311.8 6309.3 6349.9 6356.6 6362.8 6381.8 6093.1 6139.4 6146.6 6158.3 6183.1 6137.8 6147.0 6214.9 6232.0 6236.8 6044.1 6085.4 6095.9 6113.3 6171.5 6119.7 6131.2 6193.4 6244.4 6245.8 5056.5 6162.8 6169.0 6172.4 6173.8 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#1] ext.html Cycles:180 Average:69618.07 Median:38364.92 stddev:159573.66 (415.9%) stddev-sans-first:159936.95 06:05:08 INFO - PROCESS | 2529 | Values: 510.7 559.8 587.9 591.3 639.3 31341.0 31739.8 39253.0 39357.8 39381.6 42762.6 42909.1 42965.0 43518.1 43635.6 9475.2 9652.0 9715.0 9720.0 9741.3 7704.5 9300.4 9743.2 9755.1 9767.0 9598.3 9692.6 9707.4 9743.2 9757.0 8428.1 8714.5 9409.7 9720.2 9773.0 9653.6 9753.2 9776.5 9806.8 9807.3 39066.0 39072.2 39312.4 39375.0 39525.2 2647.7 2932.5 2953.9 3115.6 3339.5 22365.9 25716.5 25745.4 26413.2 26766.2 2652.6 2733.3 2766.6 2767.1 2807.9 299263.0 300487.0 300777.5 302146.0 493620.0 59997.8 60147.4 60622.4 60801.0 60898.7 61716.8 62321.7 62353.7 62436.1 62637.7 16747.5 17122.5 17135.9 17335.9 17393.3 13110.6 13359.0 13521.3 13558.9 13581.8 19919.5 20120.3 20126.6 20147.8 20254.5 6809.3 7240.6 8100.9 8132.2 8138.0 865.7 1007.7 1056.5 1073.2 1088.0 30113.0 30252.8 30336.8 30826.5 30998.9 1061.4 1090.8 1179.7 1234.3 1257.2 15225.0 15518.8 15725.0 15923.7 15980.8 744112.0 756160.0 764770.0 765012.0 766470.0 41465.0 57788.4 58952.0 59547.7 62595.7 1439.5 1491.2 1492.7 1502.8 1504.3 24662.0 29610.1 30685.7 31330.0 31341.1 54369.2 54502.0 55222.2 55311.0 55576.0 587450.0 593001.0 601988.0 602441.0 603210.0 23862.5 27324.6 27346.9 28001.7 28281.6 39000.0 46303.8 46588.8 47512.5 48486.0 35743.0 37227.3 37325.8 37973.0 37978.8 35096.1 37270.4 37308.8 37749.2 38290.4 34846.5 38439.4 38924.2 39086.2 39626.8 27217.9 28023.6 32198.3 33584.5 33713.7 20802.0 25205.2 25230.7 25504.6 25534.4 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#2] jquery.html Cycles:180 Average:33659.74 Median:11296.87 stddev:94183.06 (833.7%) stddev-sans-first:94414.16 06:05:08 INFO - PROCESS | 2529 | Values: 403.9 406.6 407.2 408.6 415.6 17488.8 20663.7 20726.0 21471.7 21581.7 15829.6 19535.2 19748.5 20538.8 20652.6 5681.8 5824.6 5890.3 5932.8 5940.4 4772.0 5837.0 5859.3 5921.8 5978.2 5815.7 5882.0 5885.6 5940.3 5961.9 5044.4 5486.5 5681.4 5808.3 5874.9 5443.2 5583.5 5675.1 5785.7 5790.1 12715.9 12901.6 13047.3 13083.7 13417.2 1958.5 1993.8 2046.5 2055.0 2146.5 8805.9 9713.5 9797.7 9892.2 9987.9 1664.2 1732.5 1740.2 1745.5 1754.7 114563.0 119054.0 119330.4 119669.0 121561.0 11465.5 11541.6 11697.8 11730.6 11785.5 13067.6 14746.8 14816.3 14890.9 15008.4 7030.6 7043.8 8118.0 8448.8 8532.4 7214.4 8370.1 8432.5 8608.7 8609.6 3736.3 4440.8 4512.3 4577.7 4580.5 1911.6 1962.6 1971.3 1976.3 1997.2 849.1 882.1 935.3 1004.0 1091.0 17217.8 17893.1 18993.8 19577.9 20162.0 995.0 996.3 1002.4 1019.7 1042.7 10376.5 10544.2 10583.6 10612.7 10628.7 529321.0 532469.0 533560.0 573289.0 620562.0 129122.0 138399.0 138419.0 145967.0 150217.0 1052.3 1077.6 1131.4 1133.3 1136.0 17859.0 17909.6 17922.3 18042.6 18246.9 52748.4 53632.7 53890.8 54194.6 54400.5 69244.7 77165.2 77879.0 78605.2 80373.0 6760.9 7659.7 7889.8 8117.4 8148.6 10691.4 12067.7 12360.8 12468.1 12487.1 10380.4 10496.5 10891.5 10953.6 10964.5 10411.9 10511.0 10534.3 10689.6 10800.4 8954.2 10997.1 11192.4 11257.4 11278.7 7909.9 7914.8 7925.3 7999.5 8263.8 8288.2 10330.4 10737.7 11122.8 11139.0 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#3] mootools.html Cycles:180 Average:5705.39 Median:4958.57 stddev:3138.23 (63.3%) stddev-sans-first:3131.89 06:05:08 INFO - PROCESS | 2529 | Values: 1603.5 1606.0 1800.4 1898.4 1990.6 7629.7 8061.2 8658.5 8664.2 8958.8 8540.1 8590.7 8626.6 8692.1 8699.2 2460.1 2485.4 2489.7 2492.4 2496.2 2427.9 2465.2 2492.0 2501.2 2529.4 2453.4 2456.8 2492.2 2506.1 2506.7 2441.9 2447.4 2467.9 2493.0 2499.8 2430.3 2430.9 2454.3 2463.9 2477.7 8874.7 8930.6 8944.3 8961.5 8981.7 5287.2 5495.2 5505.0 5508.9 5518.9 3485.6 3514.1 3557.6 3650.8 3663.1 795.5 1010.6 1035.9 1051.8 1089.1 9305.0 11421.0 11647.1 11651.9 11705.1 4667.4 4818.6 4819.9 4862.3 4924.4 9849.9 9909.1 9962.2 9979.2 10021.5 5456.9 5482.7 5486.2 5495.0 5505.4 4452.1 4797.7 4917.3 4965.0 4965.8 3946.5 4011.8 4046.3 4057.4 4159.1 1254.8 1259.1 1265.3 1274.8 1303.5 819.3 826.1 874.6 912.9 935.5 5522.6 5632.7 5907.4 5913.9 6130.0 940.0 942.8 944.8 964.0 981.6 3823.9 3921.9 3931.1 3978.1 3992.5 10356.9 10500.8 10625.2 10701.3 10711.7 10733.6 10738.6 10743.9 10773.6 11029.8 7908.3 8165.6 8269.8 8318.0 8376.8 5606.4 5740.3 5819.2 5853.3 5883.8 9917.9 9972.8 9975.0 10068.3 10102.8 9348.3 9582.8 10061.9 10087.4 10132.4 6851.9 6950.7 7337.4 7521.1 7575.2 8289.2 8305.2 8398.5 8402.3 8416.7 7280.4 7322.9 7463.7 7536.5 7545.4 7126.6 7128.5 7172.7 7239.6 7282.9 7010.5 7024.8 7071.1 7098.1 7113.7 4570.0 4636.3 4673.0 4728.8 4810.8 4905.5 4908.9 4926.7 4952.1 4999.2 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#4] prototype.html Cycles:180 Average:5324.56 Median:6079.57 stddev:1717.60 (28.3%) stddev-sans-first:1680.85 06:05:08 INFO - PROCESS | 2529 | Values: 320.3 325.1 331.8 335.7 337.3 5380.5 6093.3 6242.8 6277.2 6355.7 5866.7 6281.2 6286.0 6289.0 6292.2 3968.9 4549.2 4747.8 4768.9 4775.2 4340.2 4378.5 4427.0 4652.6 4686.0 4003.6 4053.9 4120.9 4385.9 4642.1 4154.7 4164.9 4406.4 4672.0 4685.9 3375.8 3657.2 3909.4 3933.0 3939.2 5483.6 6001.6 6017.8 6036.9 6065.8 4616.4 4796.5 4892.2 5350.0 5433.8 6094.3 6340.7 6447.7 6612.6 6672.3 4333.1 4336.3 4355.0 4359.9 4380.5 6559.4 7001.9 7076.5 7080.1 7087.5 4358.4 4374.4 4390.2 4393.2 4407.3 3970.8 4465.9 4479.1 4495.0 4504.3 4010.6 5214.4 5299.2 5364.8 5370.6 6293.6 6437.9 6706.3 6717.4 6776.2 1521.3 1533.5 1541.5 1545.4 1545.6 972.4 985.1 991.0 998.8 1006.3 6151.5 6184.4 6218.9 6224.0 6234.8 6241.3 6942.3 6942.6 6961.1 7019.2 5231.6 6203.9 6207.5 6219.4 6254.2 3611.4 3614.2 3651.9 3660.2 3681.8 5506.3 5726.8 7147.2 7181.5 7269.6 7062.4 7207.2 7222.6 7222.7 7250.5 6606.4 6786.2 7296.7 7331.9 7358.3 6921.0 6938.6 6967.9 6992.4 6995.8 6095.7 6517.2 6607.2 6870.3 6960.1 6560.9 6571.6 7260.8 7292.9 7299.2 4149.8 4402.1 4409.2 4436.8 4451.9 4951.0 5396.6 5934.7 6955.4 6978.3 6397.7 6406.6 6639.3 6706.1 6756.1 5549.8 6609.4 6620.6 6682.8 6700.8 5180.6 5403.7 6031.8 6493.3 6545.3 5578.4 6135.8 6648.5 6702.2 6766.7 5451.9 5704.3 6525.5 6531.5 6584.4 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - PROCESS | 2529 | [#5] yui.html Cycles:180 Average:18223.30 Median:28897.73 stddev:25801.76 (89.3%) stddev-sans-first:25840.49 06:05:08 INFO - PROCESS | 2529 | Values: 673.5 676.6 707.0 721.4 754.8 14518.2 14674.3 15113.0 15117.0 15271.2 14234.2 14234.7 14245.6 14421.1 14481.4 733.5 897.6 906.5 935.9 939.0 918.1 926.8 939.2 940.1 942.1 829.7 937.3 981.7 986.3 986.5 728.3 940.6 964.6 978.6 978.6 691.2 693.5 693.9 695.8 735.9 15189.2 15221.6 15295.0 15342.7 15368.8 12746.2 12854.0 12861.9 13018.9 13333.9 11047.9 11191.2 11200.0 11351.5 11574.3 4095.4 4156.4 4258.8 4296.7 4307.3 60179.7 85173.0 87486.6 88140.6 88458.0 9629.7 9814.7 9924.2 10148.8 10282.7 22692.8 22860.0 22860.7 22877.3 22893.4 7422.0 7515.9 7575.8 7583.1 7622.4 4079.2 4100.6 4120.1 4123.8 4124.4 3636.8 3652.4 3679.6 3713.1 3752.1 658.8 668.6 669.0 671.1 675.4 511.4 562.3 569.7 578.6 586.6 7576.3 7642.7 7763.8 7793.3 8118.1 496.9 529.7 567.5 569.6 579.4 3708.6 3789.1 3809.7 3813.5 3818.5 92282.5 92410.0 94140.0 94201.0 95368.5 81005.0 81224.6 81821.2 81885.0 81969.0 74627.9 75065.4 75503.0 75634.9 76273.2 6290.0 6370.3 7393.3 7525.2 7583.4 43103.0 44449.1 44612.9 44908.6 45009.4 45305.9 57225.7 57386.4 61131.0 61172.7 11070.0 11242.4 11367.3 11475.3 12225.3 11770.9 11890.6 11986.9 12043.6 12061.9 11236.7 11267.4 11276.0 11392.4 11575.0 9833.8 11399.9 11677.4 11892.9 12048.6 11204.0 11271.4 11337.7 11593.7 11793.4 7395.7 8438.1 8869.5 9348.6 9498.0 8400.6 9937.8 9948.6 10098.7 10136.7 06:05:08 INFO - PROCESS | 2529 | -------- Summary: end -------- 06:05:08 INFO - PROCESS | 2529 | 06:05:08 INFO - TEST-INFO | 2529: exit 0 06:05:08 INFO - TEST-OK | dromaeo_css | took 1112705ms 06:05:08 INFO - TEST-START | kraken 06:05:08 INFO - operating with platform_type : mac_ 06:05:08 INFO - Initialising browser for kraken test... 06:05:08 INFO - TEST-INFO | started process 2534 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpjbYiGV/profile http://localhost:61639/getInfo.html) 06:05:11 INFO - PROCESS | 2534 | __metrics Screen width/height:1600/1200 06:05:11 INFO - PROCESS | 2534 | colorDepth:24 06:05:11 INFO - PROCESS | 2534 | Browser inner width/height: 1024/689 06:05:11 INFO - PROCESS | 2534 | __metrics 06:05:11 ERROR - PROCESS | 2534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:05:12 INFO - TEST-INFO | 2534: exit 0 06:05:12 INFO - Browser initialized. 06:05:12 INFO - Running cycle 1/1 for kraken test... 06:05:12 INFO - TEST-INFO | started process 2537 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpjbYiGV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:24 INFO - PROCESS | 2537 | RSS: Main: 247525376 06:05:24 INFO - PROCESS | 2537 | 06:05:26 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61639/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:27 INFO - PROCESS | 2537 | RSS: Main: 259989504 06:05:27 INFO - PROCESS | 2537 | 06:05:30 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61639/tests/kraken/driver.html?testName=audio-dft) 06:05:31 INFO - PROCESS | 2537 | RSS: Main: 269344768 06:05:31 INFO - PROCESS | 2537 | 06:05:34 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61639/tests/kraken/driver.html?testName=audio-fft) 06:05:35 INFO - PROCESS | 2537 | RSS: Main: 272183296 06:05:35 INFO - PROCESS | 2537 | 06:05:37 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61639/tests/kraken/driver.html?testName=audio-oscillator) 06:05:37 INFO - PROCESS | 2537 | RSS: Main: 273678336 06:05:37 INFO - PROCESS | 2537 | 06:05:40 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:40 INFO - PROCESS | 2537 | RSS: Main: 274116608 06:05:40 INFO - PROCESS | 2537 | 06:05:43 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61639/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:44 INFO - PROCESS | 2537 | RSS: Main: 275587072 06:05:44 INFO - PROCESS | 2537 | 06:05:47 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61639/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:47 INFO - PROCESS | 2537 | RSS: Main: 275816448 06:05:47 INFO - PROCESS | 2537 | 06:05:50 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61639/tests/kraken/driver.html?testName=json-parse-financial) 06:05:51 INFO - PROCESS | 2537 | RSS: Main: 275931136 06:05:51 INFO - PROCESS | 2537 | 06:05:52 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:53 INFO - PROCESS | 2537 | RSS: Main: 275021824 06:05:53 INFO - PROCESS | 2537 | 06:05:55 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:56 INFO - PROCESS | 2537 | RSS: Main: 274984960 06:05:56 INFO - PROCESS | 2537 | 06:05:58 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:59 INFO - PROCESS | 2537 | RSS: Main: 275402752 06:05:59 INFO - PROCESS | 2537 | 06:06:01 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:02 INFO - PROCESS | 2537 | RSS: Main: 275517440 06:06:02 INFO - PROCESS | 2537 | 06:06:05 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:06 INFO - PROCESS | 2537 | RSS: Main: 275374080 06:06:06 INFO - PROCESS | 2537 | 06:06:07 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:61639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61639/tests/kraken/driver.html?testName=ai-astar) 06:06:08 INFO - PROCESS | 2537 | RSS: Main: 277155840 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | __start_tp_report 06:06:08 INFO - PROCESS | 2537 | _x_x_mozilla_page_load 06:06:08 INFO - PROCESS | 2537 | _x_x_mozilla_page_load_details 06:06:08 INFO - PROCESS | 2537 | |i|pagename|runs| 06:06:08 INFO - PROCESS | 2537 | |0;ai-astar;117;112;115;124;119;129;162;169;122;117 06:06:08 INFO - PROCESS | 2537 | |1;audio-beat-detection;159;123;142;168;150;170;138;118;180;147 06:06:08 INFO - PROCESS | 2537 | |2;audio-dft;195;223;245;207;275;267;198;197;206;194 06:06:08 INFO - PROCESS | 2537 | |3;audio-fft;89;70;72;133;65;81;95;94;80;54 06:06:08 INFO - PROCESS | 2537 | |4;audio-oscillator;81;128;178;115;82;80;122;76;77;124 06:06:08 INFO - PROCESS | 2537 | |5;imaging-gaussian-blur;87;85;89;126;88;85;98;131;117;86 06:06:08 INFO - PROCESS | 2537 | |6;imaging-darkroom;93;95;94;94;94;93;94;93;95;93 06:06:08 INFO - PROCESS | 2537 | |7;imaging-desaturate;90;95;90;91;93;89;124;96;148;139 06:06:08 INFO - PROCESS | 2537 | |8;json-parse-financial;62;62;62;61;62;62;61;80;64;59 06:06:08 INFO - PROCESS | 2537 | |9;json-stringify-tinderbox;64;79;96;63;107;60;61;86;96;95 06:06:08 INFO - PROCESS | 2537 | |10;stanford-crypto-aes;83;84;83;84;84;84;86;97;109;106 06:06:08 INFO - PROCESS | 2537 | |11;stanford-crypto-ccm;142;140;139;140;172;129;166;142;182;140 06:06:08 INFO - PROCESS | 2537 | |12;stanford-crypto-pbkdf2;224;185;186;172;169;165;162;195;176;160 06:06:08 INFO - PROCESS | 2537 | |13;stanford-crypto-sha256-iterative;66;63;68;57;75;99;97;98;94;79 06:06:08 INFO - PROCESS | 2537 | __end_tp_report 06:06:08 INFO - PROCESS | 2537 | __start_cc_report 06:06:08 INFO - PROCESS | 2537 | _x_x_mozilla_cycle_collect,1010 06:06:08 INFO - PROCESS | 2537 | __end_cc_report 06:06:08 INFO - PROCESS | 2537 | __startTimestamp1461243968207__endTimestamp 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | ------- Summary: start ------- 06:06:08 INFO - PROCESS | 2537 | Number of tests: 14 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#0] ai-astar Cycles:10 Average:128.60 Median:123.00 stddev:20.10 (16.3%) stddev-sans-first:20.87 06:06:08 INFO - PROCESS | 2537 | Values: 117.0 112.0 115.0 124.0 119.0 129.0 162.0 169.0 122.0 117.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:154.50 stddev:20.20 (13.1%) stddev-sans-first:21.13 06:06:08 INFO - PROCESS | 2537 | Values: 159.0 123.0 142.0 168.0 150.0 170.0 138.0 118.0 180.0 147.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#2] audio-dft Cycles:10 Average:220.70 Median:215.00 stddev:30.81 (14.3%) stddev-sans-first:31.24 06:06:08 INFO - PROCESS | 2537 | Values: 195.0 223.0 245.0 207.0 275.0 267.0 198.0 197.0 206.0 194.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#3] audio-fft Cycles:10 Average:83.30 Median:80.50 stddev:21.78 (27.1%) stddev-sans-first:23.00 06:06:08 INFO - PROCESS | 2537 | Values: 89.0 70.0 72.0 133.0 65.0 81.0 95.0 94.0 80.0 54.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:76.50 stddev:33.24 (43.5%) stddev-sans-first:33.98 06:06:08 INFO - PROCESS | 2537 | Values: 81.0 128.0 178.0 115.0 82.0 80.0 122.0 76.0 77.0 124.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#5] imaging-gaussian-blur Cycles:10 Average:99.20 Median:86.50 stddev:18.27 (21.1%) stddev-sans-first:18.84 06:06:08 INFO - PROCESS | 2537 | Values: 87.0 85.0 89.0 126.0 88.0 85.0 98.0 131.0 117.0 86.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:06:08 INFO - PROCESS | 2537 | Values: 93.0 95.0 94.0 94.0 94.0 93.0 94.0 93.0 95.0 93.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:90.50 stddev:22.58 (25.0%) stddev-sans-first:23.25 06:06:08 INFO - PROCESS | 2537 | Values: 90.0 95.0 90.0 91.0 93.0 89.0 124.0 96.0 148.0 139.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:62.00 stddev:5.93 (9.6%) stddev-sans-first:6.26 06:06:08 INFO - PROCESS | 2537 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 61.0 80.0 64.0 59.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:82.50 stddev:17.65 (21.4%) stddev-sans-first:17.66 06:06:08 INFO - PROCESS | 2537 | Values: 64.0 79.0 96.0 63.0 107.0 60.0 61.0 86.0 96.0 95.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:84.00 stddev:10.13 (12.1%) stddev-sans-first:10.43 06:06:08 INFO - PROCESS | 2537 | Values: 83.0 84.0 83.0 84.0 84.0 84.0 86.0 97.0 109.0 106.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:142.00 stddev:17.47 (12.3%) stddev-sans-first:18.34 06:06:08 INFO - PROCESS | 2537 | Values: 142.0 140.0 139.0 140.0 172.0 129.0 166.0 142.0 182.0 140.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.50 stddev:19.35 (10.7%) stddev-sans-first:12.03 06:06:08 INFO - PROCESS | 2537 | Values: 224.0 185.0 186.0 172.0 169.0 165.0 162.0 195.0 176.0 160.0 06:06:08 INFO - PROCESS | 2537 | 06:06:08 INFO - PROCESS | 2537 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.60 Median:86.50 stddev:16.17 (18.7%) stddev-sans-first:16.38 06:06:08 INFO - PROCESS | 2537 | Values: 66.0 63.0 68.0 57.0 75.0 99.0 97.0 98.0 94.0 79.0 06:06:08 INFO - PROCESS | 2537 | -------- Summary: end -------- 06:06:08 INFO - PROCESS | 2537 | 06:06:09 INFO - TEST-INFO | 2537: exit 0 06:06:09 INFO - TEST-OK | kraken | took 60539ms 06:06:09 INFO - SUITE-END | took 1173s 06:06:09 INFO - Completed test suite (00:19:33) 06:06:09 INFO - javascript benchmark 06:06:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3194.536792165136, 3481.0079127448676, 3508.403571392863, 3537.699295559877, 3580.087077795162, 4301.505326887409, 5440.727963601824, 5490.258815059966, 5916.0830071338905, 5976.671283079429, 4886.511348865111, 5083.745812709359, 5851.444112809287, 6063.939360606392, 6088.604240724349, 5296.232046353276, 5305.32579232955, 5376.7042812645195, 5378.381486129106, 5455.318085239345, 4333.804978775946, 4708.364370809931, 5436.184572314165, 5487.286652735139, 5505.889882202354, 4539.682222244444, 5310.575153987672, 5472.097103977839, 5481.506664400204, 5497.532709719679, 5320.733963301819, 5394.7842086316505, 5399.244105825188, 5429.782808687648, 5464.480874316933, 5267.209918512215, 5304.708241046741, 5334.0, 5375.0, 5381.7578208980685, 5304.151335786294, 5508.14623733322, 5820.010598198316, 5850.853728656775, 5934.050551911717, 5284.5467496438405, 6132.845047373359, 6274.623522588659, 6287.056941458772, 6290.842728931813, 6329.523667239352, 6369.617822930639, 6375.904361434582, 6381.266154392258, 6382.329855365167, 4986.977669577728, 5961.344252132262, 6090.177825993478, 6093.512518998469, 6108.938910610837, 6454.838629034311, 6471.967640161769, 6472.805815825533, 6478.4169424752, 6506.837329066717, 6236.6258024517765, 6240.344763799826, 6243.469305109116, 6254.74981000764, 6260.029695397221, 6125.815438131368, 6192.938070619236, 6307.590006649553, 6359.17330747, 6377.521685873486, 6129.908988904127, 6246.875062498724, 6258.499320054385, 6262.3111457739615, 6288.119663247149, 6236.968815155895, 6251.718672659741, 6273.37266273369, 6287.96856015717, 6295.653739044396, 4974.701517908865, 5052.671576347526, 5098.46466121052, 5124.615653825978, 5134.7946082156295, 4543.704659197141, 4577.1074640444795, 4585.77071146448, 4589.5181005994555, 4595.931061034087, 6043.637381757108, 6055.697215139314, 6073.210482637229, 6074.936886044925, 6079.939200607937, 6186.10301506279, 6250.4374606285655, 6303.0, 6352.904706429407, 6363.0455431684695, 5927.881442371128, 5931.73307201177, 6032.4570788629235, 6067.211262535842, 6076.635401875901, 4679.344891715163, 5440.863978400572, 5571.220029195916, 5579.218909352694, 5580.804671836466, 6500.577462464925, 6576.5067619928695, 6609.405153536205, 6624.701888414937, 6675.365840245266, 6351.237851457855, 6359.586626869239, 6359.7456101755415, 6362.491000720024, 6405.967970160305, 5536.2249285099315, 6361.904571431525, 6466.0947467355545, 6570.047343135314, 6576.967115164393, 6180.81457556274, 6231.875362492816, 6277.403646653561, 6288.779892703734, 6311.779087732091, 6309.337519560564, 6349.904751428639, 6356.555041147075, 6362.77730279438, 6381.776637817654, 6093.086037094471, 6139.416755408229, 6146.555559443438, 6158.261008678808, 6183.072539119168, 6137.754489820536, 6146.9550176471, 6214.937850621436, 6232.0, 6236.75052997875, 6044.0933859919605, 6085.421884920926, 6095.9390406097145, 6113.266408030887, 6171.537134715004, 6119.724612392364, 6131.162586540493, 6193.4425901669065, 6244.438000579969, 6245.750169993149, 5056.494350564914, 6162.815115546541, 6169.043798211284, 6172.444479996821, 6173.783917563043], "value": 5783.804939634186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.66551408827206, 559.7816851427947, 587.8507517802697, 591.2756872830782, 639.2520750721658, 31341.0, 31739.841300793465, 39253.0, 39357.803210983904, 39381.60618393815, 42762.57237427625, 42909.14181716372, 42965.0, 43518.12963740723, 43635.563644363545, 9475.24198064155, 9651.951740241324, 9715.0, 9719.95140024299, 9741.269404794668, 7704.537727736354, 9300.395474294182, 9743.171830394425, 9755.122039016487, 9767.0, 9598.328117031811, 9692.612295508206, 9707.369021013646, 9743.22054235663, 9756.97551757066, 8428.115047920002, 8714.520701361422, 9409.717708468723, 9720.173785228264, 9773.0, 9653.565589548418, 9753.21974242059, 9776.51117444132, 9806.803863922752, 9807.26445516582, 39066.02334941621, 39072.21855562901, 39312.410313845314, 39375.0, 39525.20949581021, 2647.695515015759, 2932.472155012097, 2953.9113826585235, 3115.610548681415, 3339.4990751387245, 22365.888170559207, 25716.457012579303, 25745.35636609081, 26413.207603771916, 26766.19701408961, 2652.562327216007, 2733.275681944286, 2766.5573508238585, 2767.1006922749984, 2807.9298017549727, 299263.0, 300487.0, 300777.4961125202, 302145.97854021617, 493620.0, 59997.800043998875, 60147.39852601506, 60622.393776062556, 60801.0, 60898.695506522185, 61716.76566468735, 62321.68839155775, 62353.688231559456, 62436.06345904815, 62637.747245054845, 16747.497575072768, 17122.48632541001, 17135.88616739908, 17335.913320433316, 17393.304267829146, 13110.60668179937, 13359.0, 13521.256330901699, 13558.915286777232, 13581.796273055912, 19919.502012449804, 20120.29578964729, 20126.59746805085, 20147.798522014593, 20254.493637659176, 6809.319068093151, 7240.565566066053, 8100.93426176333, 8132.1867813218205, 8137.959310203411, 865.7229686500385, 1007.7329507680471, 1056.498163372392, 1073.1843798713035, 1087.9718665860685, 30113.0, 30252.84873575618, 30336.84831575828, 30826.53760193599, 30998.915037973562, 1061.4109169411051, 1090.7709381030072, 1179.687382843547, 1234.2594443333928, 1257.1828311597535, 15225.0, 15518.844811551966, 15725.0, 15923.681526369408, 15980.76028859568, 744112.0, 756160.0, 764770.0, 765012.0, 766470.0, 41465.0, 57788.42211577915, 58952.0, 59547.702261489285, 62595.6870215646, 1439.4961763382942, 1491.1500444746607, 1492.701459708041, 1502.81966164061, 1504.285464404421, 24662.0, 29610.111696649135, 30685.693143068285, 31330.0, 31341.05976820699, 54369.18446223389, 54502.0, 55222.17166742422, 55311.0, 55576.0, 587450.0, 593001.0, 601988.0, 602441.0, 603210.0, 23862.522749544565, 27324.590131147652, 27346.863265683543, 28001.71998279991, 28281.57577636296, 39000.0, 46303.76848115738, 46588.7670561645, 47512.52487475081, 48486.03027939492, 35743.0, 37227.255454891296, 37325.81337093297, 37973.0, 37978.8101059504, 35096.12259693426, 37270.44094338641, 37308.813635344464, 37749.245015100096, 38290.42564361593, 34846.47730284098, 38439.423408649454, 38924.2215155701, 39086.2182756349, 39626.80186599164, 27217.86391068032, 28023.579646304916, 32198.28056362605, 33584.49623255702, 33713.66286337203, 20802.0, 25205.243842684748, 25230.74769252284, 25504.617430738184, 25534.361640959123], "value": 19768.23240008462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.91921615676864, 406.63606072565057, 407.2100125756031, 408.63631368082406, 415.6118563996252, 17488.82511174888, 20663.690044649342, 20725.963701814926, 21471.67792483114, 21581.67627485589, 15829.60425989351, 19535.21859125637, 19748.50628734279, 20538.794612053876, 20652.586948261025, 5681.801136960197, 5824.621399609033, 5890.322612899528, 5932.792352267671, 5940.3762604926505, 4771.952280477203, 5836.978528757471, 5859.326177489601, 5921.792737254197, 5978.22283103196, 5815.680137592431, 5882.029465138247, 5885.61743486672, 5940.257467816523, 5961.85095372617, 5044.39467263927, 5486.533644640211, 5681.403452637496, 5808.332041815203, 5874.88250234995, 5443.1835224716215, 5583.497485226349, 5675.063614503643, 5785.739641716133, 5790.10253410722, 12715.87284127156, 12901.612951611467, 13047.347632618426, 13083.672908177277, 13417.194968301836, 1958.5005823514912, 1993.8105879941381, 2046.5292982614083, 2054.9519744930044, 2146.4848436375314, 8805.911940880573, 9713.46575938323, 9797.706068817875, 9892.208623310118, 9987.850182247272, 1664.167916041979, 1732.5322163016042, 1740.2169023939277, 1745.5025317784498, 1754.7280171573427, 114563.0, 119054.0, 119330.40334798358, 119669.0, 121561.0, 11465.54137834494, 11541.596044138414, 11697.824532632018, 11730.589429370102, 11785.469653865597, 13067.607971760863, 14746.778798317819, 14816.3332650031, 14890.925545372203, 15008.399664013317, 7030.613316267654, 7043.788686339418, 8118.0, 8448.78878028042, 8532.402731808714, 7214.422846172293, 8370.079291277954, 8432.451890627211, 8608.698695545625, 8609.61256743448, 3736.308782875177, 4440.800163992628, 4512.278035514302, 4577.679562430598, 4580.496145424001, 1911.5890083632087, 1962.6271008508338, 1971.3297478857257, 1976.3280484635293, 1997.211101614854, 849.1423662101199, 882.0759183307443, 935.3172184305495, 1004.0320970897124, 1090.9945450272699, 17217.794754367325, 17893.10534473271, 18993.81006189948, 19577.902110489358, 20162.0, 994.9950250248702, 996.3324572536418, 1002.4236064263077, 1019.6788011776267, 1042.74452759073, 10376.533056012497, 10544.209184311207, 10583.576656933636, 10612.681619551426, 10628.734281643021, 529321.0, 532469.0, 533560.0, 573289.0, 620562.0, 129122.0, 138399.0, 138419.0, 145967.0, 150217.0, 1052.2897044494935, 1077.590515604081, 1131.4229742831214, 1133.3086817041599, 1135.9772804543863, 17859.0, 17909.552261193574, 17922.283108675507, 18042.639147217244, 18246.908765456617, 52748.36258187152, 53632.73183634213, 53890.766554006885, 54194.64513387039, 54400.45599543954, 69244.65377673079, 77165.22834771805, 77879.0, 78605.2139478598, 80373.0, 6760.850655388694, 7659.731909383145, 7889.75227072726, 8117.391195660467, 8148.5518296494265, 10691.358518488916, 12067.698307542381, 12360.75278494443, 12468.127231093737, 12487.12590118683, 10380.429076400871, 10496.47517624131, 10891.455427228766, 10953.56185752561, 10964.451777411257, 10411.94794026025, 10511.0, 10534.315269507457, 10689.625863094754, 10800.40597767099, 8954.238889694449, 10997.065249453886, 11192.38441885704, 11257.437128143723, 11278.661640150809, 7909.9209007909185, 7914.762557123296, 7925.326347260317, 7999.520028798058, 8263.834723305621, 8288.171182881664, 10330.431826249629, 10737.731556711145, 11122.777544449227, 11138.997490225594], "value": 9231.791634715475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1603.454825359378, 1605.9839401605984, 1800.3878681248373, 1898.3545594497878, 1990.5521257717007, 7629.656665450054, 8061.234182752629, 8658.523781192032, 8664.176903194202, 8958.776030599238, 8540.145985401457, 8590.742277731662, 8626.568671566412, 8692.130786921305, 8699.217070463657, 2460.052879641333, 2485.3662316109458, 2489.65144879717, 2492.439201179729, 2496.1887386599337, 2427.8786060696984, 2465.2480993297036, 2492.0405643827166, 2501.17461237792, 2529.4435224250637, 2453.4479742057983, 2456.778889899909, 2492.1651246832243, 2506.0727530813624, 2506.724260331362, 2441.914532991346, 2447.400386905211, 2467.864267465289, 2493.0, 2499.8375105618256, 2430.2952143878256, 2430.890609922558, 2454.349597356684, 2463.864487453189, 2477.690288713911, 8874.733757987271, 8930.598123084477, 8944.284457243404, 8961.507117108556, 8981.685641002534, 5287.154055351125, 5495.230667706524, 5504.972475137639, 5508.889822203533, 5518.862028449281, 3485.5817301923676, 3514.0863375522295, 3557.5908770491465, 3650.7809531428197, 3663.065918190871, 795.5465384730705, 1010.5503051142244, 1035.9482025898674, 1051.7580956380075, 1089.0742868561738, 9305.022972587849, 11421.0, 11647.126465515035, 11651.883481165165, 11705.122115841346, 4667.416572928384, 4818.613886690849, 4819.855404337875, 4862.294967229803, 4924.409070911442, 9849.901500985041, 9909.058639429388, 9962.203023758228, 9979.201663866874, 10021.549030293654, 5456.863578410492, 5482.698451585121, 5486.1770734389365, 5495.0, 5505.449455054462, 4452.109578084396, 4797.712137271775, 4917.286993385939, 4965.0, 4965.776540055706, 3946.546147193052, 4011.8395264189107, 4046.2716710992304, 4057.411675307123, 4159.126583417456, 1254.8243245945575, 1259.0619988108917, 1265.2724683306951, 1274.7832868412393, 1303.478608556566, 819.3117781063935, 826.1490664615455, 874.5627186406797, 912.8630705394244, 935.4714586258742, 5522.5581953443625, 5632.662040277596, 5907.409259074058, 5913.852153696106, 6129.969350153221, 939.9812003759887, 942.8255772682076, 944.7779771753633, 963.9807203856024, 981.6355266180016, 3823.9235215296094, 3921.941170882439, 3931.1351502669368, 3978.1446988896946, 3992.5208974923194, 10356.896431035744, 10500.842487362695, 10625.203109766799, 10701.250912436055, 10711.732206694895, 10733.570657173781, 10738.570457181782, 10743.946280268548, 10773.62292319765, 11029.83455248172, 7908.327792137733, 8165.63254653542, 8269.793255168548, 8317.958410208032, 8376.790580235665, 5606.355269144101, 5740.253767010262, 5819.243498345188, 5853.326867410302, 5883.764649413975, 9917.851232231667, 9972.750681233027, 9974.950125249617, 10068.295219334575, 10102.79794404093, 9348.298877584073, 9582.808343832945, 10061.949690251502, 10087.39475631435, 10132.44271565071, 6851.897221541781, 6950.652467376712, 7337.376323012603, 7521.05986751656, 7575.24247575238, 8289.212524810133, 8305.211004954519, 8398.496090234605, 8402.285805706584, 8416.747497575083, 7280.417566594766, 7322.890156647548, 7463.701451941862, 7536.547807131589, 7545.358644515058, 7126.572405655677, 7128.536645118051, 7172.748953786592, 7239.601821899846, 7282.854342913006, 7010.544314619533, 7024.754133605299, 7071.116110486189, 7098.148222213367, 7113.679884405111, 4569.977150114228, 4636.281376386665, 4673.0, 4728.787204575871, 4810.783514741915, 4905.48492408292, 4908.852734417973, 4926.704397736147, 4952.133376659142, 4999.175136102503], "value": 4615.518870575176, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.300144184956, 325.1351405262003, 331.8291080093751, 335.67942614802865, 337.33376581252014, 5380.488853558915, 6093.299270583873, 6242.843928901774, 6277.246730392354, 6355.7139928703145, 5866.685322792619, 6281.183446151994, 6285.968570157154, 6288.968555157229, 6292.244930608334, 3968.9404658929993, 4549.226631472658, 4747.8338258160975, 4768.856934291968, 4775.212090005145, 4340.240457919851, 4378.452693413324, 4427.0, 4652.604528615072, 4685.976570117162, 4003.5996400360023, 4053.945974046754, 4120.917581648365, 4385.912281754363, 4642.07158568286, 4154.688398370119, 4164.895877603054, 4406.383106365111, 4672.0, 4685.8594242172785, 3375.8312084395684, 3657.2319812839337, 3909.377608292555, 3933.0, 3939.2273476935493, 5483.561315094783, 6001.609895356832, 6017.849553761147, 6036.9396306036815, 6065.848353791146, 4616.44602647681, 4796.544328288807, 4892.168331383673, 5350.0, 5433.809816656438, 6094.329623741385, 6340.682965851689, 6447.742090316382, 6612.636305003223, 6672.33106757301, 4333.090051089275, 4336.327869180251, 4355.0, 4359.8882285017435, 4380.474343078851, 6559.409653131241, 7001.929980700179, 7076.513932074271, 7080.114985626797, 7087.468439866979, 4358.36803663467, 4374.4094547236355, 4390.165868484977, 4393.1872603568445, 4407.2507673695545, 3970.841166353371, 4465.866024019285, 4479.148961697267, 4495.0, 4504.324351347324, 4010.6189911958318, 5214.426413094557, 5299.178627312773, 5364.8122315718765, 5370.624056316098, 6293.559450838397, 6437.871242575122, 6706.329367063352, 6717.429018533479, 6776.15298087739, 1521.269790500566, 1533.5476034569829, 1541.5201406649517, 1545.4436402894949, 1545.63677535779, 972.3873959405671, 985.1380042462845, 990.9752256193652, 998.8451789972565, 1006.2955930848435, 6151.477124444383, 6184.443400094013, 6218.906716399258, 6223.96888015557, 6234.75060997555, 6241.251049873953, 6942.271061538567, 6942.618156001367, 6961.060256865359, 7019.227884932653, 5231.607629427808, 6203.875922481525, 6207.503399728102, 6219.440250377488, 6254.249490061222, 3611.422172452395, 3614.1868079682386, 3651.94522082169, 3660.194757153422, 3681.815909204529, 5506.311711036121, 5726.77092916287, 7147.249538798351, 7181.4972951893915, 7269.600171990592, 7062.364387205176, 7207.207207207203, 7222.566646001257, 7222.7472038479455, 7250.456215783837, 6606.438452731475, 6786.219584747719, 7296.744613938593, 7331.890021649573, 7358.300961408658, 6921.031055652314, 6938.618375989369, 6967.895481567679, 6992.4406047517095, 6995.790126296016, 6095.725692343766, 6517.185351831021, 6607.174103237096, 6870.3473170048765, 6960.095187625576, 6560.868782624416, 6571.57284776488, 7260.818479538054, 7292.854142917218, 7299.226294008243, 4149.813258403439, 4402.053558484941, 4409.22838503267, 4436.82252709888, 4451.910961780682, 4951.009278772725, 5396.631974270242, 5934.732937017931, 6955.426492197919, 6978.336373404003, 6397.744090236339, 6406.583572067801, 6639.269680335063, 6706.128203333536, 6756.121704178426, 5549.833504994856, 6609.372109649576, 6620.6427682325975, 6682.799516014527, 6700.765473208415, 5180.559652429586, 5403.729813509231, 6031.75872965094, 6493.253275873146, 6545.345465453416, 5578.414266502121, 6135.754569817157, 6648.501362397937, 6702.229243637044, 6766.661666916733, 5451.945480545302, 5704.286964129484, 6525.510586705921, 6531.477481801539, 6584.390926351477], "value": 4768.61981020107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.4948788408691, 676.580520077552, 706.9540479868805, 721.3760097515651, 754.7660225330148, 14518.201498917555, 14674.339654715537, 15112.999999999973, 15116.999999999985, 15271.236438178088, 14234.217118058503, 14234.715305693906, 14245.572632821006, 14421.134731916092, 14481.42074317026, 733.5122143774383, 897.5915958239018, 906.4697152165991, 935.854942483916, 938.9906100939006, 918.0681608167715, 926.8378033844084, 939.2157548447055, 940.1068984464752, 942.0673533202115, 829.7386323308139, 937.3485427627801, 981.6711401680445, 986.3440811860105, 986.4968865878418, 728.3153835394738, 940.6096469965024, 964.5868802204768, 978.5694294510392, 978.5938835383344, 691.1740470138187, 693.5110746923407, 693.923668396481, 695.8121307247065, 735.9411247100219, 15189.240537973168, 15221.61945951349, 15295.0, 15342.693146137015, 15368.769468457982, 12746.235225886383, 12854.0, 12861.87138128616, 13018.86981130186, 13333.933330333286, 11047.944760276147, 11191.216614836965, 11200.0, 11351.489182986785, 11574.305541667527, 4095.406166105898, 4156.376543518466, 4258.765767882765, 4296.74219546825, 4307.289297265978, 60179.699101504215, 85173.0, 87486.5625671874, 88140.5592972031, 88458.0, 9629.711108666752, 9814.65648702292, 9924.206063514901, 10148.797024059477, 10282.691519254435, 22692.773072269065, 22860.0, 22860.65709014366, 22877.31368058961, 22893.427664308194, 7421.962890185622, 7515.887261691079, 7575.848483030309, 7583.090029196532, 7622.428317876182, 4079.1841631673783, 4100.610442008005, 4120.072983578671, 4123.835046598102, 4124.4019617155345, 3636.818159092035, 3652.3790955537625, 3679.632036796299, 3713.0717320669833, 3752.1182522107283, 658.8319978405476, 668.6021817018866, 669.0332469581506, 671.0906721392442, 675.4022689919457, 511.4042140905803, 562.3364429972671, 569.7493103034651, 578.5863107877803, 586.5981802465325, 7576.28025337592, 7642.700740874065, 7763.844723105506, 7793.298603125746, 8118.092188672946, 496.9155243608523, 529.6599701572175, 567.4637467593168, 569.5870493891978, 579.3655946738314, 3708.647678470541, 3789.147441825567, 3809.7142714296538, 3813.523309586302, 3818.4845045919, 92282.53858730664, 92410.0, 94140.0, 94201.0, 95368.52315738377, 81005.0, 81224.59387703023, 81821.18178818254, 81885.0, 81969.0, 74627.88058179132, 75065.36889931794, 75503.0, 75634.86547701788, 76273.23726762773, 6289.962156244169, 6370.29926708071, 7393.260673932564, 7525.24747525265, 7583.355414789805, 43103.0, 44449.11101778011, 44612.88467788331, 44908.550914490435, 45009.42467013639, 45305.86735331643, 57225.71387143204, 57386.42613573811, 61131.0, 61172.69413652903, 11070.0, 11242.437878106226, 11367.261128026652, 11475.311481311148, 12225.266484010632, 11770.882291176978, 11890.643280701594, 11986.880131198577, 12043.578474753342, 12061.879381206076, 11236.719082023015, 11267.436628168394, 11276.041536469493, 11392.43037848121, 11574.974379483388, 9833.754156145867, 11399.943000284946, 11677.357745324089, 11892.881071189177, 12048.638540843789, 11204.047655949336, 11271.436428178722, 11337.716557086138, 11593.6521904343, 11793.410329483662, 7395.667194976347, 8438.071812100787, 8869.512176830336, 9348.626054957998, 9497.952510237405, 8400.579971001303, 9937.801243975224, 9948.55231514598, 10098.747531311776, 10136.695899123039], "value": 6905.163524515619, "unit": "score"}], "name": "dromaeo_css", "value": 7371.381477042751, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 115.0, 124.0, 119.0, 129.0, 162.0, 169.0, 122.0, 117.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 142.0, 168.0, 150.0, 170.0, 138.0, 118.0, 180.0, 147.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 223.0, 245.0, 207.0, 275.0, 267.0, 198.0, 197.0, 206.0, 194.0], "value": 220.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 72.0, 133.0, 65.0, 81.0, 95.0, 94.0, 80.0, 54.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 128.0, 178.0, 115.0, 82.0, 80.0, 122.0, 76.0, 77.0, 124.0], "value": 106.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 126.0, 88.0, 85.0, 98.0, 131.0, 117.0, 86.0], "value": 99.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 90.0, 91.0, 93.0, 89.0, 124.0, 96.0, 148.0, 139.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 80.0, 64.0, 59.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 96.0, 63.0, 107.0, 60.0, 61.0, 86.0, 96.0, 95.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 84.0, 84.0, 86.0, 97.0, 109.0, 106.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 139.0, 140.0, 172.0, 129.0, 166.0, 142.0, 182.0, 140.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 185.0, 186.0, 172.0, 169.0, 165.0, 162.0, 195.0, 176.0, 160.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 68.0, 57.0, 75.0, 99.0, 97.0, 98.0, 94.0, 79.0], "value": 79.6, "unit": "score"}], "name": "kraken", "value": 1629.3000000000002, "alertThreshold": 2.0}]} 06:06:09 INFO - Return code: 0 06:06:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:09 ERROR - # TBPL SUCCESS # 06:06:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:09 INFO - 2016-04-21 06:06:09.529 screenresolution[2542:44031] starting screenresolution argv=screenresolution get 06:06:09 INFO - 2016-04-21 06:06:09.533 screenresolution[2542:44031] Display 0: 1600x1200x32@60 06:06:09 INFO - 2016-04-21 06:06:09.539 screenresolution[2543:44034] starting screenresolution argv=screenresolution list 06:06:09 INFO - Available Modes on Display 0 06:06:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:09 INFO - Intel Iris: 06:06:09 INFO - Chipset Model: Intel Iris 06:06:09 INFO - Type: GPU 06:06:09 INFO - Bus: Built-In 06:06:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:09 INFO - Vendor: Intel (0x8086) 06:06:09 INFO - Device ID: 0x0a2e 06:06:09 INFO - Revision ID: 0x0009 06:06:09 INFO - Displays: 06:06:09 INFO - Display: 06:06:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:09 INFO - Display Serial Number: 1600x1200 60 06:06:09 INFO - Main Display: Yes 06:06:09 INFO - Mirror: Off 06:06:09 INFO - Online: Yes 06:06:09 INFO - Rotation: Supported 06:06:09 INFO - Return code: 0 06:06:09 INFO - Running post-action listener: _resource_record_post_action 06:06:09 INFO - Running post-run listener: _resource_record_post_run 06:06:10 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 344064; Write bytes: 695203328; Read time: 4; Write time: 1914 06:06:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 383910400; Write bytes: 377730560; Read time: 28241; Write time: 680 06:06:10 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 344064; Write bytes: 296638464; Read time: 4; Write time: 1163 06:06:10 INFO - Running post-run listener: _upload_blobber_files 06:06:10 INFO - Blob upload gear active. 06:06:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:10 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 06:06:10 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'] 06:06:10 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 06:06:11 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:12 INFO - (blobuploader) - INFO - Done attempting. 06:06:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:13 INFO - (blobuploader) - INFO - Done attempting. 06:06:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:13 INFO - Return code: 0 06:06:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d954752ff142cfd4469a3c9aa3422af4bca07a61952110ed8197e9b99e43586b355621e6dbc5e7bdc5149b153329ee2dca7c5b030d7204d71692ecc2f0fe549", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c9a06213a75e1a5a3e412f3f2a28e54fa5abd2d9046154eb2fab819f9853c32021d4588f6222da2616514ce3241c64cea4503bf68d022834f641fe249993928"} 06:06:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:13 INFO - Contents: 06:06:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d954752ff142cfd4469a3c9aa3422af4bca07a61952110ed8197e9b99e43586b355621e6dbc5e7bdc5149b153329ee2dca7c5b030d7204d71692ecc2f0fe549", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c9a06213a75e1a5a3e412f3f2a28e54fa5abd2d9046154eb2fab819f9853c32021d4588f6222da2616514ce3241c64cea4503bf68d022834f641fe249993928"} 06:06:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:13 INFO - Copying logs to upload dir... 06:06:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.681290 ========= master_lag: 22.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-21 06:06:35.779597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-21 06:06:35.784095) ========= 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.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d954752ff142cfd4469a3c9aa3422af4bca07a61952110ed8197e9b99e43586b355621e6dbc5e7bdc5149b153329ee2dca7c5b030d7204d71692ecc2f0fe549", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c9a06213a75e1a5a3e412f3f2a28e54fa5abd2d9046154eb2fab819f9853c32021d4588f6222da2616514ce3241c64cea4503bf68d022834f641fe249993928"} build_url:https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011654 build_url: 'https://queue.taskcluster.net/v1/task/M1xzmBpeSKGkk6Qd8IrTtw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d954752ff142cfd4469a3c9aa3422af4bca07a61952110ed8197e9b99e43586b355621e6dbc5e7bdc5149b153329ee2dca7c5b030d7204d71692ecc2f0fe549", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c9a06213a75e1a5a3e412f3f2a28e54fa5abd2d9046154eb2fab819f9853c32021d4588f6222da2616514ce3241c64cea4503bf68d022834f641fe249993928"}' ========= master_lag: 5.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-21 06:06:41.405513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 17 mins, 53 secs) (at 2016-04-21 06:06:41.405832) ========= 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.kcViQzL7zM/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.7ItrjUlvzj/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005240 ========= master_lag: 1073.76 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 17 mins, 53 secs) (at 2016-04-21 06:24:35.167246) ========= ========= Started reboot skipped (results: 3, elapsed: 7 secs) (at 2016-04-21 06:24:35.167517) ========= ========= Finished reboot skipped (results: 3, elapsed: 7 secs) (at 2016-04-21 06:24:42.338279) ========= ========= Total master_lag: 1101.60 =========